2025-11-11T14:15:48.665674Z :GRPC_SERVER NOTICE: grpc_request_proxy_simple.cpp:161: Grpc simple request proxy started, nodeid# 1
2025-11-11T14:15:48.665957Z :MEMORY_PROFILER NOTICE: monitor.cpp:332: Bootstrapped
2025-11-11T14:15:48.672971Z :FQ_LOG_UPDATER DEBUG: log.cpp:93: Updated YQL logs priority: 8
2025-11-11T14:15:48.672979Z :GRPC_SERVER NOTICE: grpc_request_proxy_simple.cpp:161: Grpc simple request proxy started, nodeid# 1
2025-11-11T14:15:48.672981Z :FQ_LOG_UPDATER CRIT: log.cpp:55: Failed to deliver subscription request to config dispatcher.
2025-11-11T14:15:48.673004Z :YQ_CONTROL_PLANE_STORAGE INFO: ydb_control_plane_storage.cpp:50: Starting ydb control plane storage service. Actor id: [1:7571471352548076120:2062]
2025-11-11T14:15:48.673027Z :FQ_CONTROL_PLANE_CONFIG DEBUG: control_plane_config.cpp:58: STARTING: [1:7571471352548076121:2063]
2025-11-11T14:15:48.673121Z :YQ_CONTROL_PLANE_PROXY DEBUG: control_plane_proxy.cpp:532: Starting yandex query control plane proxy. Actor id: [1:7571471352548076122:2064]
2025-11-11T14:15:48.673840Z :YQ_RATE_LIMITER INFO: quoter_service.cpp:124: Bootstraping with config: { Enabled: true ControlPlaneEnabled: true DataPlaneEnabled: true Database { Endpoint: "localhost:3770" Database: "local" TablePrefix: "RateLimiter_f5b6631e-434f-418b-bbbc-2b42f29bdcb4" } Limiters { CoordinationNodePath: "rate_limiter" } }
2025-11-11T14:15:48.673964Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:188: Bootstrap
2025-11-11T14:15:48.673971Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:191: Create sdk ydb connection
2025-11-11T14:15:48.673995Z :STREAMS_STORAGE_SERVICE TRACE: storage_proxy.cpp:213: Initialize
2025-11-11T14:15:48.674089Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:209: Successfully bootstrapped TStorageProxy [1:7571471352548076126:2068] with connection to localhost:3770:local
2025-11-11T14:15:48.674100Z :FQ_ROW_DISPATCHER DEBUG: row_dispatcher.cpp:534: RowDispatcher: Successfully bootstrapped row dispatcher, id [1:7571471352548076127:2069], tenant /default
2025-11-11T14:15:48.674399Z :YQL_NODES_MANAGER INFO: nodes_manager.cpp:88: Bootstrap, InstanceId: 4175c08c-4e2d972f-f8fe069c-a191640f
2025-11-11T14:15:48.674407Z :YQL_NODES_MANAGER DEBUG: nodes_manager.cpp:310: TNodesManagerActor::ResolveSelfAddress
2025-11-11T14:15:48.674419Z :YQ_TEST_CONNECTION DEBUG: test_connection.cpp:142: Starting yandex query test connection. Actor id: [1:7571471352548076132:2074]
2025-11-11T14:15:48.678908Z :FQ_QUOTA_PROXY INFO: quota_proxy.cpp:90: STARTED
2025-11-11T14:15:48.678945Z :FQ_QUOTA_SERVICE INFO: quota_manager.cpp:196: STARTED
2025-11-11T14:15:48.678971Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 7645876b-61afea9c-2673eaf9-2d459ee91, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:15:48.678988Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create directory "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4" actor
2025-11-11T14:15:48.678990Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create directory "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4"
2025-11-11T14:15:48.678999Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:383: Call create directory "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4"
2025-11-11T14:15:48.679001Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/queries" actor
2025-11-11T14:15:48.679007Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/pending_small" actor
2025-11-11T14:15:48.679021Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/connections" actor
2025-11-11T14:15:48.679023Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/bindings" actor
2025-11-11T14:15:48.679032Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/idempotency_keys" actor
2025-11-11T14:15:48.679035Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/result_sets" actor
2025-11-11T14:15:48.679037Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/jobs" actor
2025-11-11T14:15:48.679046Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/nodes" actor
2025-11-11T14:15:48.679046Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/quotas" actor
2025-11-11T14:15:48.679047Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/tenants" actor
2025-11-11T14:15:48.679057Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/tenant_acks" actor
2025-11-11T14:15:48.679062Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/mappings" actor
2025-11-11T14:15:48.679064Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/compute_databases" actor
2025-11-11T14:15:48.679066Z :YQ_RATE_LIMITER DEBUG: schema.cpp:71: Run create coordination node "local/RateLimiter_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/rate_limiter" actor
2025-11-11T14:15:48.679068Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create coordination node "local/RateLimiter_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/rate_limiter"
2025-11-11T14:15:48.679070Z :YQ_RATE_LIMITER DEBUG: schema.cpp:411: Call create coordination node "local/RateLimiter_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/rate_limiter"
2025-11-11T14:15:48.679078Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:267: Coordinator: Successfully bootstrapped coordinator, id [1:7571471352548076173:2110], NodesManagerId [0:4705493345362661702:78]
2025-11-11T14:15:48.679081Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:232: TLeaderElection [1:7571471352548076174:2111] Successfully bootstrapped, local coordinator id [1:7571471352548076173:2110], tenant id default, local mode 0, coordination node path local/row_dispatcher/default, endpoint localhost:3770
2025-11-11T14:15:48.679090Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:318: TNodesManagerActor::NodesHealthCheck
2025-11-11T14:15:48.679269Z :FQ_ROW_DISPATCHER DEBUG: row_dispatcher.cpp:627: RowDispatcher: TEvCoordinatorChangesSubscribe from [1:7571471352548076173:2110]
2025-11-11T14:15:48.680805Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:71: Run create coordination node "local/row_dispatcher/default" actor
2025-11-11T14:15:48.680814Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:113: Call create coordination node "local/row_dispatcher/default"
2025-11-11T14:15:48.680816Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:411: Call create coordination node "local/row_dispatcher/default"
2025-11-11T14:15:48.689627Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:15:48.689655Z :FQ_PENDING_FETCHER ERROR: pending_fetcher.cpp:259: Error with GetTask: <main>: Error: GRpc error: (14): connections to all backends failing; last error: UNKNOWN: ipv4:127.0.0.1:65509: Failed to connect to remote host: Connection refused
<main>: Error: Grpc error response on endpoint localhost:65509
2025-11-11T14:15:48.689711Z :YQL_NODES_MANAGER ERROR: nodes_manager.cpp:395: ydb/core/fq/libs/actors/nodes_manager.cpp:353: TRANSPORT_UNAVAILABLE
<main>: Error: GRpc error: (14): connections to all backends failing; last error: UNKNOWN: ipv4:127.0.0.1:65509: Failed to connect to remote host: Connection refused
<main>: Error: Grpc error response on endpoint localhost:65509
2025-11-11T14:15:48.774602Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/queries". Create session OK
2025-11-11T14:15:48.774618Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/queries"
2025-11-11T14:15:48.774620Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/queries"
2025-11-11T14:15:48.777904Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/compute_databases". Create session OK
2025-11-11T14:15:48.777923Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/compute_databases"
2025-11-11T14:15:48.777925Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/compute_databases"
2025-11-11T14:15:48.778259Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/nodes". Create session OK
2025-11-11T14:15:48.778263Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/nodes"
2025-11-11T14:15:48.778265Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/nodes"
2025-11-11T14:15:48.778285Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/connections". Create session OK
2025-11-11T14:15:48.778290Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/connections"
2025-11-11T14:15:48.778292Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/connections"
2025-11-11T14:15:48.778417Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/mappings". Create session OK
2025-11-11T14:15:48.778418Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/mappings"
2025-11-11T14:15:48.778419Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/mappings"
2025-11-11T14:15:48.778450Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/pending_small". Create session OK
2025-11-11T14:15:48.778456Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/pending_small"
2025-11-11T14:15:48.778459Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/pending_small"
2025-11-11T14:15:48.778494Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:155: Successfully created coordination node "local/row_dispatcher/default"
2025-11-11T14:15:48.778503Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:122: Reply for create coordination node "local/row_dispatcher/default": { <main>: Error: Check failed: path: '/local/row_dispatcher/default', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 12], type: EPathTypeKesus, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_create_kesus.cpp:339 }
2025-11-11T14:15:48.778517Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:345: TLeaderElection [1:7571471352548076174:2111] Coordination node successfully created
2025-11-11T14:15:48.778519Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:323: TLeaderElection [1:7571471352548076174:2111] Start session
2025-11-11T14:15:48.778534Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/bindings". Create session OK
2025-11-11T14:15:48.778536Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/bindings"
2025-11-11T14:15:48.778537Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/bindings"
2025-11-11T14:15:48.778599Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/idempotency_keys". Create session OK
2025-11-11T14:15:48.778600Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/idempotency_keys"
2025-11-11T14:15:48.778603Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/idempotency_keys"
2025-11-11T14:15:48.778649Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/quotas". Create session OK
2025-11-11T14:15:48.778650Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/quotas"
2025-11-11T14:15:48.778651Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/quotas"
2025-11-11T14:15:48.793161Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created directory "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4"
2025-11-11T14:15:48.793187Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create directory "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4": { <main>: Error: Check failed: path: '/local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 29], type: EPathTypeDir, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_mkdir.cpp:155 }
2025-11-11T14:15:48.793199Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/result_sets". Create session OK
2025-11-11T14:15:48.793202Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/result_sets"
2025-11-11T14:15:48.793204Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/result_sets"
2025-11-11T14:15:48.793328Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:359: TLeaderElection [1:7571471352548076174:2111] Session successfully created
2025-11-11T14:15:48.794098Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/jobs". Create session OK
2025-11-11T14:15:48.794110Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/jobs"
2025-11-11T14:15:48.794112Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/jobs"
2025-11-11T14:15:48.794142Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/tenants". Create session OK
2025-11-11T14:15:48.794147Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/tenants"
2025-11-11T14:15:48.794150Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/tenants"
2025-11-11T14:15:48.794229Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/tenant_acks". Create session OK
2025-11-11T14:15:48.794231Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/tenant_acks"
2025-11-11T14:15:48.794233Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/tenant_acks"
2025-11-11T14:15:48.794268Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/mappings"
2025-11-11T14:15:48.794276Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/mappings": { <main>: Error: Check failed: path: '/local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/mappings', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 31], type: EPathTypeTable, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:504 }
2025-11-11T14:15:48.807678Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:372: TLeaderElection [1:7571471352548076174:2111] Semaphore successfully created
2025-11-11T14:15:48.807691Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:304: TLeaderElection [1:7571471352548076174:2111] Try to acquire semaphore
2025-11-11T14:15:48.807760Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:420: TLeaderElection [1:7571471352548076174:2111] Describe semaphore
2025-11-11T14:15:48.810324Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/tenants"
2025-11-11T14:15:48.810341Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/tenants": { <main>: Error: Check failed: path: '/local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/tenants', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 30], type: EPathTypeTable, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:504 }
2025-11-11T14:15:48.812295Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:386: TLeaderElection [1:7571471352548076174:2111] Semaphore successfully acquired
2025-11-11T14:15:48.813302Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:469: TLeaderElection [1:7571471352548076174:2111] Semaphore successfully described: coordinator id [1:7571471352548076173:2110] generation 2
2025-11-11T14:15:48.813316Z :FQ_ROW_DISPATCHER INFO: leader_election.cpp:471: TLeaderElection [1:7571471352548076174:2111] Send TEvCoordinatorChanged to [1:7571471352548076127:2069], new coordinator id [1:7571471352548076173:2110], previous coordinator id [0:0:0]
2025-11-11T14:15:48.813335Z :FQ_ROW_DISPATCHER DEBUG: row_dispatcher.cpp:559: RowDispatcher: Coordinator changed, old leader (empty maybe), new [1:7571471352548076173:2110] generation 2
2025-11-11T14:15:48.813345Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:314: Coordinator: TEvPing received, [1:7571471352548076127:2069]
2025-11-11T14:15:48.813349Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:317: Coordinator: Send TEvPong to [1:7571471352548076127:2069]
2025-11-11T14:15:48.813356Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:386: Coordinator: New leader [1:7571471352548076173:2110], SelfId [1:7571471352548076173:2110]
2025-11-11T14:15:48.813359Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:623: RowDispatcher: NActors::TEvents::TEvPong
2025-11-11T14:15:48.828568Z :YQ_RATE_LIMITER DEBUG: schema.cpp:155: Successfully created coordination node "local/RateLimiter_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/rate_limiter"
2025-11-11T14:15:48.828580Z :YQ_RATE_LIMITER DEBUG: schema.cpp:122: Reply for create coordination node "local/RateLimiter_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/rate_limiter": 
2025-11-11T14:15:48.840995Z :FQ_CONTROL_PLANE_CONFIG DEBUG: control_plane_config.cpp:190: LOADED TenantInfo: State CHANGED at 2025-11-11T14:15:47.725537Z
2025-11-11T14:15:48.841031Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/queries"
2025-11-11T14:15:48.841035Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/queries": 
2025-11-11T14:15:48.841039Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/idempotency_keys"
2025-11-11T14:15:48.841044Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/idempotency_keys": 
2025-11-11T14:15:48.841169Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/connections"
2025-11-11T14:15:48.841184Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/connections": 
2025-11-11T14:15:48.841268Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/compute_databases"
2025-11-11T14:15:48.841270Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/compute_databases": 
2025-11-11T14:15:48.841277Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/nodes"
2025-11-11T14:15:48.841281Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/nodes": 
2025-11-11T14:15:48.851897Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/quotas"
2025-11-11T14:15:48.851908Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/quotas": 
2025-11-11T14:15:48.852098Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/jobs"
2025-11-11T14:15:48.852101Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/jobs": 
2025-11-11T14:15:48.852396Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/pending_small"
2025-11-11T14:15:48.852403Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/pending_small": 
2025-11-11T14:15:48.875033Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/bindings"
2025-11-11T14:15:48.875056Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/bindings": 
2025-11-11T14:15:48.875435Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/result_sets"
2025-11-11T14:15:48.875443Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/result_sets": 
2025-11-11T14:15:48.875481Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/tenant_acks"
2025-11-11T14:15:48.875483Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/tenant_acks": 
2025-11-11T14:15:48.875757Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:499: Checkpoint storage and state storage were successfully inited
2025-11-11T14:15:49.263190Z :TICKET_PARSER DEBUG: ticket_parser_impl.h:1828: Ticket **** (B6C6F477) (ipv6:[::1]:60966) has now valid token of root@builtin
2025-11-11T14:15:49.263588Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:655: CreateQueryRequest: content {
  type: STREAMING
  name: "q"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "SELECT 42;"
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "b91595e0-0b24-4373-9f76-f576d031e7a9"
2025-11-11T14:15:49.263634Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:313: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7571471356843043534:2156]
2025-11-11T14:15:49.263669Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:375: Cloud id: mock_cloud Folder id: my_folder
2025-11-11T14:15:49.263699Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:92: Get quotas bootstrap. Cloud id: mock_cloud Actor id: [1:7571471356843043535:2157]
2025-11-11T14:15:49.263722Z :FQ_QUOTA_SERVICE DEBUG: quota_manager.cpp:255: cloud.mock_cloud NOT CASHED, Loading ...
2025-11-11T14:15:49.289218Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:441: cloud.mock_cloud {} FROM DB
2025-11-11T14:15:49.289253Z :FQ_QUOTA_SERVICE DEBUG: quota_manager.cpp:269: cloud.mock_cloud{yq.streamingQueryDurationMinutes.count=*/0, yq.queryResult.size=*/20971520, yq.analyticsQuery.count=*/100, yq.analyticsQueryDurationMinutes.count=*/1440, yq.memory.size=*/0, yq.result.size=*/0, yq.cpuPercent.count=*/10000, yq.streamingQuery.count=*/100} LOADED
2025-11-11T14:15:49.289269Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.analyticsQuery.count IS STALE, Refreshing ...
2025-11-11T14:15:49.289285Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.cpuPercent.count IS STALE, Refreshing ...
2025-11-11T14:15:49.289299Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:291: cloud.mock_cloud.yq.streamingQuery.count IS STALE, Refreshing ...
2025-11-11T14:15:49.289322Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:703: cloud.mock_cloud.yq.cpuPercent.count=0/10000 REFRESHED
2025-11-11T14:15:49.343893Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:703: cloud.mock_cloud.yq.analyticsQuery.count=0/100 REFRESHED
2025-11-11T14:15:49.343927Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:703: cloud.mock_cloud.yq.streamingQuery.count=0/100 REFRESHED
2025-11-11T14:15:49.343952Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:493: cloud.mock_cloud{yq.streamingQueryDurationMinutes.count=*/0, yq.queryResult.size=*/20971520, yq.analyticsQuery.count=0/100, yq.analyticsQueryDurationMinutes.count=*/1440, yq.memory.size=*/0, yq.result.size=*/0, yq.cpuPercent.count=0/10000, yq.streamingQuery.count=0/100} SEND QUOTAS
2025-11-11T14:15:49.343976Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:108: Cloud id: mock_cloud Quota count: 8
2025-11-11T14:15:49.344031Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:655: CreateQueryRequest: content {
  type: STREAMING
  name: "q"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "SELECT 42;"
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "b91595e0-0b24-4373-9f76-f576d031e7a9"
2025-11-11T14:15:49.344110Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:176: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7571471356843043541:2163]
2025-11-11T14:15:49.344131Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:237: Subject Type: federated_account Token: **** (B6C6F477)
2025-11-11T14:15:49.344154Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:655: CreateQueryRequest: content {
  type: STREAMING
  name: "q"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "SELECT 42;"
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "b91595e0-0b24-4373-9f76-f576d031e7a9"
2025-11-11T14:15:49.344170Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:444: Create database bootstrap. CloudId: mock_cloud Scope: yandexcloud://my_folder Actor id: [1:7571471356843043542:2164]
2025-11-11T14:15:49.344192Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:655: CreateQueryRequest: content {
  type: STREAMING
  name: "q"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "SELECT 42;"
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "b91595e0-0b24-4373-9f76-f576d031e7a9"
2025-11-11T14:15:49.344202Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:69: Request actor. Actor id: [1:7571471356843043543:2165]
2025-11-11T14:15:49.344222Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:253: Create rate limiter resource for cloud with limit 100000ms
2025-11-11T14:15:49.344256Z :YQ_RATE_LIMITER DEBUG: schema.cpp:71: Run create rate limiter resource "mock_cloud" actor
2025-11-11T14:15:49.344261Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create rate limiter resource "mock_cloud"
2025-11-11T14:15:49.370470Z :YQ_RATE_LIMITER DEBUG: schema.cpp:155: Successfully created rate limiter resource "mock_cloud"
2025-11-11T14:15:49.370486Z :YQ_RATE_LIMITER DEBUG: schema.cpp:122: Reply for create rate limiter resource "mock_cloud": 
2025-11-11T14:15:49.370525Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.cpuPercent.count=0/10000 NOTIFY CHANGE
2025-11-11T14:15:49.370535Z :YQ_CONTROL_PLANE_PROXY DEBUG: request_actor.h:277: Create response from rate limiter service. Success: 1
2025-11-11T14:15:49.370665Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:226: CreateQueryRequest: {content {
  type: STREAMING
  name: "q"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "SELECT 42;"
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "b91595e0-0b24-4373-9f76-f576d031e7a9"
} [root@builtin, **** (B6C6F477)] 
2025-11-11T14:15:49.393245Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.analyticsQuery.count=0/100 NOTIFY CHANGE
2025-11-11T14:15:49.397077Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:510: cloud.mock_cloud.yq.streamingQuery.count=0/100 NOTIFY CHANGE
2025-11-11T14:15:49.499695Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: CreateQueryRequest - CreateQueryResult: {query_id: "ptqudslmrhta5v3oppmv" } SUCCESS
2025-11-11T14:15:49.502666Z :TICKET_PARSER DEBUG: ticket_parser_impl.h:1828: Ticket **** (B6C6F477) (ipv6:[::1]:60966) has now valid token of root@builtin
2025-11-11T14:15:49.502775Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
2025-11-11T14:15:49.502808Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:313: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7571471356843043548:2169]
2025-11-11T14:15:49.502836Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:375: Cloud id: mock_cloud Folder id: my_folder
2025-11-11T14:15:49.502899Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
2025-11-11T14:15:49.502978Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:176: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7571471356843043549:2170]
2025-11-11T14:15:49.503009Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:237: Subject Type: federated_account Token: **** (B6C6F477)
2025-11-11T14:15:49.503037Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
2025-11-11T14:15:49.503068Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:69: Request actor. Actor id: [1:7571471356843043550:2171]
2025-11-11T14:15:49.503142Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudslmrhta5v3oppmv"
} [root@builtin, **** (B6C6F477)] 
2025-11-11T14:15:49.545338Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudslmrhta5v3oppmv" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1762870549 nanos: 370576000 } modified_at { seconds: 1762870549 nanos: 370576000 } revision: 1 } execute_mode: RUN status: STARTING last_job_query_revision: 1 last_job_id: "ptjudslmrhta4nukmvna-ptqudslmrhta5v3oppmv" started_by: "root@builtin" submitted_at { seconds: 1762870549 nanos: 370576000 } } content { type: STREAMING name: "q" acl { visibility: PRIVATE } limits { execution_timeout { } } text: "SELECT 42;" syntax: YQL_V1 } } } SUCCESS
2025-11-11T14:15:49.678331Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:542: Coordinator: Send TEvGetNodesRequest to NodesManager
2025-11-11T14:15:49.678332Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:15:49.678348Z :YQL_NODES_MANAGER DEBUG: nodes_manager.cpp:300: TNodesManagerActor::TEvGetNodesRequest
2025-11-11T14:15:49.678359Z :FQ_ROW_DISPATCHER INFO: coordinator.cpp:573: Coordinator: Updated node info, node count: 0
2025-11-11T14:15:49.688579Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 7645876b-61afea9c-2673eaf9-2d459ee92, Host: ghrun-vb3yoermsa, Tenant: /default, Request CP::GetTask with size: 68 bytes
2025-11-11T14:15:49.689254Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "7645876b-61afea9c-2673eaf9-2d459ee92"
host: "ghrun-vb3yoermsa"
node_id: 1
}
2025-11-11T14:15:49.741017Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:463: Task (Query): ptqudslmrhta5v3oppmv RetryRate: 0 RetryCounter: 0 At: 2025-11-11T14:15:49.451026Z
2025-11-11T14:15:49.845196Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {tasks { query_id { value: "ptqudslmrhta5v3oppmv" } job_id { value: "ptjudslmrhta4nukmvna" } generation: 1 streaming: true text: "SELECT 42;" user_token: "root@builtin" user_id: "root@builtin" query_type: STREAMING scope: "yandexcloud://my_folder" execute_mode: RUN state_load_mode: EMPTY status: STARTING sensor_labels { key: "cloud_id" value: "mock_cloud" } sensor_labels { key: "scope" value: "yandexcloud://my_folder" } query_name: "q" deadline { seconds: 1762956949 nanos: 788816000 } 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: 1762870549 nanos: 370576000 } } } SUCCESS
2025-11-11T14:15:49.845242Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 7645876b-61afea9c-2673eaf9-2d459ee92, Host: ghrun-vb3yoermsa, Tenant: /default, Got CP::GetTask Response
2025-11-11T14:15:49.845703Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:15:49.845714Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 1
2025-11-11T14:15:49.845728Z :FQ_PENDING_FETCHER DEBUG: pending_fetcher.cpp:361: NewTask: Scope: yandexcloud://my_folder Id: ptqudslmrhta5v3oppmv UserId: root@builtin AuthToken: **** (B6C6F477)
2025-11-11T14:15:49.845845Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:375: QueryId: ptqudslmrhta5v3oppmv Start run actor. Compute state: STARTING
2025-11-11T14:15:49.845856Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:469: QueryId: ptqudslmrhta5v3oppmv FillConnections
2025-11-11T14:15:49.845857Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 7645876b-61afea9c-2673eaf9-2d459ee93, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:15:49.845881Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:2333: QueryId: ptqudslmrhta5v3oppmv Run actors params: { QueryId: ptqudslmrhta5v3oppmv CloudId: mock_cloud UserId: root@builtin Owner: 7645876b-61afea9c-2673eaf9-2d459ee92 PreviousQueryRevision: 1 Connections: 0 Bindings: 0 AccountIdSignatures: 0 QueryType: STREAMING ExecuteMode: RUN ResultId: ptrudslmrheq7v6kdmu0 StateLoadMode: EMPTY StreamingDisposition: { fresh { } } Status: STARTING DqGraphs: 0 DqGraphIndex: 0 Resource.TopicConsumers: 0 }
2025-11-11T14:15:49.845908Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:571: QueryId: ptqudslmrhta5v3oppmv Start rate limiter resource creator
2025-11-11T14:15:49.845927Z :FQ_PINGER TRACE: pinger.cpp:171: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92 Start Pinger
2025-11-11T14:15:49.845963Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92 Forward ping request: { started_at { seconds: 1762870549 nanos: 845000000 } }
2025-11-11T14:15:49.845971Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92 Forward request Private::PingTask
2025-11-11T14:15:49.845987Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92 Forward ping request: { status: RUNNING resources { rate_limiter: PREPARE compilation: PREPARE } }
2025-11-11T14:15:49.847609Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 7645876b-61afea9c-2673eaf9-2d459ee93, Host: ghrun-vb3yoermsa, Tenant: /default, Request CP::GetTask with size: 68 bytes
2025-11-11T14:15:49.847661Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "7645876b-61afea9c-2673eaf9-2d459ee93"
host: "ghrun-vb3yoermsa"
node_id: 1
}
2025-11-11T14:15:49.849242Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:78: PrivateCreateRateLimiterResource - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92, Request CP::CreateRateLimiterResource with size: 97 bytes
2025-11-11T14:15:49.849284Z :YQ_CONTROL_PLANE_STORAGE TRACE: request_actor.h:57: CreateRateLimiterResourceRequest: {owner_id: "7645876b-61afea9c-2673eaf9-2d459ee92"
query_id {
  value: "ptqudslmrhta5v3oppmv"
}
scope: "yandexcloud://my_folder"
tenant: "/default"
} 
2025-11-11T14:15:49.849331Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92, Request CP::PingTask with size: 129 bytes
2025-11-11T14:15:49.849404Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "7645876b-61afea9c-2673eaf9-2d459ee92"
query_id {
  value: "ptqudslmrhta5v3oppmv"
}
scope: "yandexcloud://my_folder"
started_at {
  seconds: 1762870549
  nanos: 845000000
}
deadline {
  seconds: 1762956949
  nanos: 788816000
}
tenant: "/default"
}
2025-11-11T14:15:49.850011Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-11-11T14:15:49.850036Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 7645876b-61afea9c-2673eaf9-2d459ee93, Host: ghrun-vb3yoermsa, Tenant: /default, Got CP::GetTask Response
2025-11-11T14:15:49.850333Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:15:49.850351Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-11-11T14:15:49.881935Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:74: CreateRateLimiterResourceRequest. Got response from database: SUCCESS
2025-11-11T14:15:49.882051Z :YQ_RATE_LIMITER DEBUG: schema.cpp:71: Run create rate limiter resource "mock_cloud/my_folder/ptqudslmrhta5v3oppmv" actor
2025-11-11T14:15:49.882061Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create rate limiter resource "mock_cloud/my_folder/ptqudslmrhta5v3oppmv"
2025-11-11T14:15:49.883137Z :YQ_RATE_LIMITER DEBUG: schema.cpp:261: Trying to recursively create rate limiter resource "mock_cloud/my_folder"
2025-11-11T14:15:49.883146Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create rate limiter resource "mock_cloud/my_folder"
2025-11-11T14:15:49.885068Z :YQ_RATE_LIMITER DEBUG: schema.cpp:244: Successfully created rate limiter resource "mock_cloud/my_folder"
2025-11-11T14:15:49.885076Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create rate limiter resource "mock_cloud/my_folder/ptqudslmrhta5v3oppmv"
2025-11-11T14:15:49.887035Z :YQ_RATE_LIMITER DEBUG: schema.cpp:155: Successfully created rate limiter resource "mock_cloud/my_folder/ptqudslmrhta5v3oppmv"
2025-11-11T14:15:49.887045Z :YQ_RATE_LIMITER DEBUG: schema.cpp:122: Reply for create rate limiter resource "mock_cloud/my_folder/ptqudslmrhta5v3oppmv": 
2025-11-11T14:15:49.887078Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:180: Got create response from rate limiter service
2025-11-11T14:15:49.887100Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:102: PrivateCreateRateLimiterResource - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92, Got CP::CreateRateLimiterResourceResponse
2025-11-11T14:15:49.887447Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1477: QueryId: ptqudslmrhta5v3oppmv Rate limiter resource creation finished. Success: 1
2025-11-11T14:15:49.887464Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1966: QueryId: ptqudslmrhta5v3oppmv Compiling query ...
2025-11-11T14:15:49.887509Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92 Forward ping request: { status: RUNNING resources { rate_limiter: READY compilation: PREPARE rate_limiter_path: "local/RateLimiter_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/rate_limiter" } }
2025-11-11T14:15:49.923869Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.923 TRACE ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_facade.cpp:899: Execution of [ParseSql] took 35.5ms
2025-11-11T14:15:49.924199Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.924 TRACE ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_facade.cpp:940: Execution of [Compile] took 303us
2025-11-11T14:15:49.924307Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.924 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [DQ] yql_dq_provider.cpp:109: OpenSession ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud
2025-11-11T14:15:49.924320Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.924 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [DQ] yql_dq_provider.cpp:112: OpenSession ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud complete in 0
2025-11-11T14:15:49.924384Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.924 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_expr_optimize.cpp:671: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [ExpandApply] took 13us
2025-11-11T14:15:49.924443Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.924 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [core eval] yql_eval_expr.cpp:421: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} EvaluateExpression - start
2025-11-11T14:15:49.924517Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.924 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [core eval] yql_eval_expr.cpp:1204: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} EvaluateExpression - finish
2025-11-11T14:15:49.924631Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.924 INFO  ydbd(pid=927307, tid=0x00007F7777D3D640) [PQ] yql_pq_helpers.cpp:100: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Ids to resolve: 0
2025-11-11T14:15:49.924730Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.924 INFO  ydbd(pid=927307, tid=0x00007F7777D3D640) [RESULT] yql_result_provider.cpp:1415: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} RewriteIO
2025-11-11T14:15:49.925279Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.925 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [core] type_ann_expr.cpp:159: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Repeated callable stats:
RemovePrefixMembers=1
TypeOf=1
PersistableRepr=1
OrderedSqlProject=1
SqlProjectItem=1
ResWrite!=1

2025-11-11T14:15:49.925304Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.925 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] type_ann_expr.cpp:48: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 552us
2025-11-11T14:15:49.925362Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.925 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] type_ann_expr.cpp:48: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 23us
2025-11-11T14:15:49.925376Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.925 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] type_ann_expr.cpp:48: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 1us
2025-11-11T14:15:49.925437Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.925 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_expr_constraint.cpp:3312: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [ConstraintTransformer::DoTransform] took 50us
2025-11-11T14:15:49.925468Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.925 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] type_ann_expr.cpp:48: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 0us
2025-11-11T14:15:49.925480Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.925 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] type_ann_expr.cpp:48: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 1us
2025-11-11T14:15:49.925507Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.925 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_expr_constraint.cpp:3312: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [ConstraintTransformer::DoTransform] took 17us
2025-11-11T14:15:49.925522Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.925 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_expr_csee.cpp:638: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [UpdateCompletness] took 5us
2025-11-11T14:15:49.925547Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.925 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_expr_csee.cpp:651: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [EliminateCommonSubExpressions] took 20us
2025-11-11T14:15:49.925589Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.925 TRACE ydbd(pid=927307, tid=0x00007F7777D3D640) [core] yql_out_transformers.cpp:62: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} OptimizedExpr:
(
(let $1 (Configure! world (DataSource '"config") '"DqEngine" '"force"))
(let $2 (DataSink 'result))
(let $3 '('('type) '('autoref) '('columns '('"column0"))))
(let $4 (ResWrite! $1 $2 (Key) (Unordered (OrderedSqlProject (AsList (AsStruct)) '((SqlProjectItem (ListType (StructType)) '"column0" (lambda '($5) (Int32 '"42")) '())))) $3))
(return (Commit! $4 $2))
)

2025-11-11T14:15:49.925788Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.925 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [core] yql_co_simple1.cpp:6780: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Expand OrderedSqlProject
2025-11-11T14:15:49.925860Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.925 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] type_ann_expr.cpp:48: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 0us
2025-11-11T14:15:49.925918Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.925 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] type_ann_expr.cpp:48: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 46us
2025-11-11T14:15:49.925946Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.925 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_expr_constraint.cpp:3312: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [ConstraintTransformer::DoTransform] took 13us
2025-11-11T14:15:49.925972Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.925 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] type_ann_expr.cpp:48: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 0us
2025-11-11T14:15:49.925984Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.925 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] type_ann_expr.cpp:48: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 0us
2025-11-11T14:15:49.926012Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.926 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_expr_constraint.cpp:3312: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [ConstraintTransformer::DoTransform] took 20us
2025-11-11T14:15:49.926029Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.926 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_expr_csee.cpp:638: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [UpdateCompletness] took 6us
2025-11-11T14:15:49.926063Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.926 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_expr_csee.cpp:651: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [EliminateCommonSubExpressions] took 23us
2025-11-11T14:15:49.926110Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.926 TRACE ydbd(pid=927307, tid=0x00007F7777D3D640) [core] yql_out_transformers.cpp:62: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} OptimizedExpr:
(
(let $1 (Configure! world (DataSource '"config") '"DqEngine" '"force"))
(let $2 (DataSink 'result))
(let $3 '('('type) '('autoref) '('columns '('"column0"))))
(let $4 (ResWrite! $1 $2 (Key) (Unordered (OrderedFlatMap (AsList (AsStruct)) (lambda '($5) (AsList (FlattenMembers '('"" (AsStruct '('"column0" (Int32 '"42"))))))))) $3))
(return (Commit! $4 $2))
)

2025-11-11T14:15:49.926143Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.926 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [core] yql_opt_utils.cpp:896: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Enumerate struct literal for FlattenMembers
2025-11-11T14:15:49.926188Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.926 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] type_ann_expr.cpp:48: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 0us
2025-11-11T14:15:49.926228Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.926 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] type_ann_expr.cpp:48: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 27us
2025-11-11T14:15:49.926248Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.926 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_expr_constraint.cpp:3312: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [ConstraintTransformer::DoTransform] took 7us
2025-11-11T14:15:49.926271Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.926 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] type_ann_expr.cpp:48: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 0us
2025-11-11T14:15:49.926288Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.926 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] type_ann_expr.cpp:48: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 1us
2025-11-11T14:15:49.926313Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.926 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_expr_constraint.cpp:3312: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [ConstraintTransformer::DoTransform] took 13us
2025-11-11T14:15:49.926327Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.926 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_expr_csee.cpp:638: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [UpdateCompletness] took 5us
2025-11-11T14:15:49.926356Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.926 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_expr_csee.cpp:651: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [EliminateCommonSubExpressions] took 18us
2025-11-11T14:15:49.926397Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.926 TRACE ydbd(pid=927307, tid=0x00007F7777D3D640) [core] yql_out_transformers.cpp:62: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} OptimizedExpr:
(
(let $1 (Configure! world (DataSource '"config") '"DqEngine" '"force"))
(let $2 (DataSink 'result))
(let $3 '('('type) '('autoref) '('columns '('"column0"))))
(let $4 (ResWrite! $1 $2 (Key) (Unordered (OrderedFlatMap (AsList (AsStruct)) (lambda '($5) (AsList (AsStruct '('"column0" (Int32 '"42"))))))) $3))
(return (Commit! $4 $2))
)

2025-11-11T14:15:49.926436Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.926 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [core] yql_co_simple1.cpp:2115: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Fuse OrderedFlatMap over AsList
2025-11-11T14:15:49.926482Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.926 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] type_ann_expr.cpp:48: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 0us
2025-11-11T14:15:49.926507Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.926 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] type_ann_expr.cpp:48: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 14us
2025-11-11T14:15:49.926526Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.926 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_expr_constraint.cpp:3312: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [ConstraintTransformer::DoTransform] took 7us
2025-11-11T14:15:49.926537Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.926 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_expr_csee.cpp:638: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [UpdateCompletness] took 4us
2025-11-11T14:15:49.926564Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.926 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_expr_csee.cpp:651: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [EliminateCommonSubExpressions] took 16us
2025-11-11T14:15:49.926597Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.926 TRACE ydbd(pid=927307, tid=0x00007F7777D3D640) [core] yql_out_transformers.cpp:62: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} OptimizedExpr:
(
(let $1 (Configure! world (DataSource '"config") '"DqEngine" '"force"))
(let $2 (DataSink 'result))
(let $3 '('('type) '('autoref) '('columns '('"column0"))))
(let $4 (ResWrite! $1 $2 (Key) (Unordered (AsList (AsStruct '('"column0" (Int32 '"42"))))) $3))
(return (Commit! $4 $2))
)

2025-11-11T14:15:49.926613Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.926 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [core] yql_co_simple1.cpp:6497: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Drop Unordered over AsList
2025-11-11T14:15:49.926637Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.926 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] type_ann_expr.cpp:48: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 0us
2025-11-11T14:15:49.926652Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.926 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] type_ann_expr.cpp:48: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 7us
2025-11-11T14:15:49.926664Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.926 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_expr_constraint.cpp:3312: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [ConstraintTransformer::DoTransform] took 4us
2025-11-11T14:15:49.926675Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.926 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_expr_csee.cpp:638: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [UpdateCompletness] took 4us
2025-11-11T14:15:49.926699Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.926 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_expr_csee.cpp:651: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [EliminateCommonSubExpressions] took 14us
2025-11-11T14:15:49.926730Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.926 TRACE ydbd(pid=927307, tid=0x00007F7777D3D640) [core] yql_out_transformers.cpp:62: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} OptimizedExpr:
(
(let $1 (Configure! world (DataSource '"config") '"DqEngine" '"force"))
(let $2 (DataSink 'result))
(let $3 '('('type) '('autoref) '('columns '('"column0"))))
(let $4 (ResWrite! $1 $2 (Key) (AsList (AsStruct '('"column0" (Int32 '"42")))) $3))
(return (Commit! $4 $2))
)

2025-11-11T14:15:49.927048Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.927 TRACE ydbd(pid=927307, tid=0x00007F7777D3D640) [core dq] dq_opt_phy_finalizing.cpp:488: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} DqReplicateStageMultiOutput: start traverse node #209100, Commit!
2025-11-11T14:15:49.927097Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.927 INFO  ydbd(pid=927307, tid=0x00007F7777D3D640) [RESULT] yql_result_provider.cpp:801: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} ResFill
2025-11-11T14:15:49.927136Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.927 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] type_ann_expr.cpp:48: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 0us
2025-11-11T14:15:49.927167Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.927 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] type_ann_expr.cpp:48: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [TypeAnnotationTransformer::DoTransform] took 19us
2025-11-11T14:15:49.927187Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.927 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_expr_constraint.cpp:3312: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [ConstraintTransformer::DoTransform] took 8us
2025-11-11T14:15:49.927203Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.927 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_expr_csee.cpp:638: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [UpdateCompletness] took 4us
2025-11-11T14:15:49.927230Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.927 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_expr_csee.cpp:651: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution of [EliminateCommonSubExpressions] took 15us
2025-11-11T14:15:49.927258Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.927 TRACE ydbd(pid=927307, tid=0x00007F7777D3D640) [core] yql_out_transformers.cpp:62: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} OptimizedExpr:
(
(let $1 (Configure! world (DataSource '"config") '"DqEngine" '"force"))
(let $2 (DataSink 'result))
(let $3 '('('type) '('autoref) '('columns '('"column0"))))
(let $4 (ResFill! $1 $2 (Key) (AsList (AsStruct '('"column0" (Int32 '"42")))) $3 '"dq"))
(return (Commit! $4 $2))
)

2025-11-11T14:15:49.927379Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.927 TRACE ydbd(pid=927307, tid=0x00007F7777D3D640) [core dq] dq_opt_phy_finalizing.cpp:488: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} DqReplicateStageMultiOutput: start traverse node #209104, Commit!
2025-11-11T14:15:49.927460Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.927 INFO  ydbd(pid=927307, tid=0x00007F7777D3D640) [core exec] yql_execution.cpp:61: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Begin, root #209104
2025-11-11T14:15:49.927472Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.927 INFO  ydbd(pid=927307, tid=0x00007F7777D3D640) [core exec] yql_execution.cpp:74: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Collect unused nodes for root #209104, status: Ok
2025-11-11T14:15:49.927481Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.927 TRACE ydbd(pid=927307, tid=0x00007F7777D3D640) [core exec] yql_execution.cpp:411: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} {0}, callable #209104 <Commit!>
2025-11-11T14:15:49.927488Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.927 TRACE ydbd(pid=927307, tid=0x00007F7777D3D640) [core exec] yql_execution.cpp:411: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} {1}, callable #209103 <ResFill!>
2025-11-11T14:15:49.927500Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.927 TRACE ydbd(pid=927307, tid=0x00007F7777D3D640) [core exec] yql_execution.cpp:411: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} {2}, callable #208965 <Configure!>
2025-11-11T14:15:49.927509Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.927 TRACE ydbd(pid=927307, tid=0x00007F7777D3D640) [core exec] yql_execution.cpp:411: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} {2}, callable #208965 <Configure!>
2025-11-11T14:15:49.927519Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.927 INFO  ydbd(pid=927307, tid=0x00007F7777D3D640) [core exec] yql_execution.cpp:630: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Node #208965<Configure!> finished execution
2025-11-11T14:15:49.927531Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.927 INFO  ydbd(pid=927307, tid=0x00007F7777D3D640) [core exec] yql_execution.cpp:647: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Node #208965<Configure!> created 0 trackable nodes: 
2025-11-11T14:15:49.927539Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.927 TRACE ydbd(pid=927307, tid=0x00007F7777D3D640) [core exec] yql_execution.cpp:411: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} {1}, callable #209103 <ResFill!>
2025-11-11T14:15:49.927578Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.927 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [DQ] yql_dq_exectransformer.cpp:890: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud/#209103/#209113} Executing Result (UniqueId=209113)
2025-11-11T14:15:49.927667Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.927 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [core] type_ann_expr.cpp:159: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud/#209103/#209113} Repeated callable stats:
ToStream=1

2025-11-11T14:15:49.927683Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.927 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] type_ann_expr.cpp:48: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud/#209103/#209113} Execution of [TypeAnnotationTransformer::DoTransform] took 28us
2025-11-11T14:15:49.927696Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.927 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] type_ann_expr.cpp:48: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud/#209103/#209113} Execution of [TypeAnnotationTransformer::DoTransform] took 1us
2025-11-11T14:15:49.927707Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.927 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_expr_constraint.cpp:3312: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud/#209103/#209113} Execution of [ConstraintTransformer::DoTransform] took 4us
2025-11-11T14:15:49.927719Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.927 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_expr_csee.cpp:638: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud/#209103/#209113} Execution of [UpdateCompletness] took 2us
2025-11-11T14:15:49.927734Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.927 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_expr_csee.cpp:651: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud/#209103/#209113} Execution of [EliminateCommonSubExpressionsForSubGraph] took 5us
2025-11-11T14:15:49.927756Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.927 TRACE ydbd(pid=927307, tid=0x00007F7777D3D640) [core peephole] yql_out_transformers.cpp:62: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud/#209103/#209113} PeepHoleOpt:
(
(return (Iterator (AsList (AsStruct '('"column0" (Int32 '"42"))))))
)

2025-11-11T14:15:49.960562Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.960 TRACE ydbd(pid=927307, tid=0x00007F7777D3D640) [core dq] dq_opt_phy_finalizing.cpp:488: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud/#209103/#209113} DqReplicateStageMultiOutput: start traverse node #209115, Iterator
2025-11-11T14:15:49.960609Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.960 TRACE ydbd(pid=927307, tid=0x00007F7777D3D640) [core dq] dq_opt_build.cpp:235: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud/#209103/#209113} [DQ/Build/TransformConsumers] (
(return (Iterator (AsList (AsStruct '('"column0" (Int32 '"42"))))))
)

2025-11-11T14:15:49.960623Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.960 TRACE ydbd(pid=927307, tid=0x00007F7777D3D640) [core dq] dq_opt_build.cpp:325: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud/#209103/#209113} [DQ/Build/TransformPhysical] (
(return (Iterator (AsList (AsStruct '('"column0" (Int32 '"42"))))))
)

2025-11-11T14:15:49.960765Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.960 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] type_ann_expr.cpp:48: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud/#209103/#209113} Execution of [TypeAnnotationTransformer::DoTransform] took 4us
2025-11-11T14:15:49.960781Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.960 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_expr_constraint.cpp:3312: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud/#209103/#209113} Execution of [ConstraintTransformer::DoTransform] took 3us
2025-11-11T14:15:49.960790Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.960 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_expr_csee.cpp:638: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud/#209103/#209113} Execution of [UpdateCompletness] took 3us
2025-11-11T14:15:49.960803Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.960 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [perf] yql_expr_csee.cpp:651: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud/#209103/#209113} Execution of [EliminateCommonSubExpressionsForSubGraph] took 7us
2025-11-11T14:15:49.960817Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.960 TRACE ydbd(pid=927307, tid=0x00007F7777D3D640) [core peephole] yql_out_transformers.cpp:62: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud/#209103/#209113} PeepHoleOpt:
(
(return (Iterator (AsList (AsStruct '('"column0" (Int32 '"42"))))))
)

2025-11-11T14:15:49.960902Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.960 TRACE ydbd(pid=927307, tid=0x00007F7777D3D640) [DQ] yql_dq_exectransformer.cpp:2143: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud/#209103/#209113} After PeepHole
(
(return (Iterator (AsList (AsStruct '('"column0" (Int32 '"42"))))))
)

2025-11-11T14:15:49.961445Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:928: QueryId: ptqudslmrhta5v3oppmv Graph (execution) with tasks: 1
2025-11-11T14:15:49.961459Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.961 INFO  ydbd(pid=927307, tid=0x00007F7777D3D640) [core exec] yql_execution.cpp:519: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Register async execution for node #209103
2025-11-11T14:15:49.961474Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.961 INFO  ydbd(pid=927307, tid=0x00007F7777D3D640) [core exec] yql_execution.cpp:89: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Finish, output #209104, status: Async
2025-11-11T14:15:49.961537Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.961 INFO  ydbd(pid=927307, tid=0x00007F7777D3D640) [core exec] yql_execution.cpp:135: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Completed async execution for node #209103
2025-11-11T14:15:49.961553Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.961 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [DQ] yql_dq_exectransformer.cpp:1083: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud WrapFutureCallback
2025-11-11T14:15:49.961561Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.961 INFO  ydbd(pid=927307, tid=0x00007F7777D3D640) [DQ] yql_dq_exectransformer.cpp:1086: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Execution Result complete, duration: 0.033971s
2025-11-11T14:15:49.961598Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.961 INFO  ydbd(pid=927307, tid=0x00007F7777D3D640) [core exec] yql_execution.cpp:155: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} State is ExecutionComplete after apply async changes for node #209103
2025-11-11T14:15:49.961609Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.961 INFO  ydbd(pid=927307, tid=0x00007F7777D3D640) [core exec] yql_execution.cpp:61: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Begin, root #209104
2025-11-11T14:15:49.961614Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.961 INFO  ydbd(pid=927307, tid=0x00007F7777D3D640) [core exec] yql_execution.cpp:74: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Collect unused nodes for root #209104, status: Ok
2025-11-11T14:15:49.961620Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.961 TRACE ydbd(pid=927307, tid=0x00007F7777D3D640) [core exec] yql_execution.cpp:411: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} {0}, callable #209104 <Commit!>
2025-11-11T14:15:49.961642Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.961 INFO  ydbd(pid=927307, tid=0x00007F7777D3D640) [core exec] yql_execution.cpp:630: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Node #209104<Commit!> finished execution
2025-11-11T14:15:49.961653Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.961 INFO  ydbd(pid=927307, tid=0x00007F7777D3D640) [core exec] yql_execution.cpp:647: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Node #209104<Commit!> created 0 trackable nodes: 
2025-11-11T14:15:49.961658Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.961 INFO  ydbd(pid=927307, tid=0x00007F7777D3D640) [core exec] yql_execution.cpp:89: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Finish, output #209104, status: Ok
2025-11-11T14:15:49.961663Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:49.961 INFO  ydbd(pid=927307, tid=0x00007F7777D3D640) [core exec] yql_execution.cpp:95: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Creating finalizing transformer, output #209104
2025-11-11T14:15:49.961809Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:911: QueryId: ptqudslmrhta5v3oppmv Overall dq tasks: 1
2025-11-11T14:15:49.961827Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 7645876b-61afea9c-2673eaf9-2d459ee9 2025-11-11 14:15:49.961 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [DQ] yql_dq_provider.cpp:126: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} CloseSession ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud
2025-11-11T14:15:49.961857Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92 Forward ping request: { ast: "(\n(let $1 (Configure! world (DataSource \'\"config\") \'\"DqEngine\" \'\"force\"))\n(let $2 (DataSink \'result))\n(let $3 \'(\'(\'type) \'(\'autoref) \'(\'columns \'(\'\"column0\"))))\n(let $4 (ResFill! $1 $2 (Key) (AsList (AsStruct \'(\'\"column0\" (Int32 \'\"42\")))) $3 \'\"dq\"))\n(return (Commit! $4 $2))\n)\n" plan: "{\"Detailed\":{\"Operations\":[{\"Id\":2,\"Name\":\"ResFill!\"}],\"OperationRoot\":2,\"Providers\":[],\"OperationStats\":{\"ResFill!\":1}},\"Basic\":{\"nodes\":[{\"id\":2,\"level\":1,\"name\":\"ResFill!\",\"type\":\"op\"}],\"links\":[]}}" }
2025-11-11T14:15:49.961942Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:758: QueryId: ptqudslmrhta5v3oppmv Graph 0
2025-11-11T14:15:49.962008Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92 Forward ping request: { result_set_count: 1 result_set_meta { column { name: "column0" type { type_id: INT32 } } } dq_graph: "\022\320\002\010\001\022\024\n\022\t\000\000\000\000\000\000\000\000\021\000\000\000\000\000\000\000\000\032\004\010\240\215\00628\n4\010\001\030\002 \001*\024\n\022\t\000\000\000\000\000\000\000\000\021\000\000\000\000\000\000\000\0002\024\n\022\t\001\000\000\000\000\000\000\000\021\000\000\000\000\001\000\000\000X\001R\000:s\n*type.googleapis.com/Yql.DqsProto.TTaskMeta\022E\010\001\022A\022(8d73c3b672aec01e659c446142c7a17d47fb7b86\032\023dq_vanilla_job.lite \002H\001RClocal/RateLimiter_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/rate_limiterZ)mock_cloud/my_folder/ptqudslmrhta5v3oppmv`\200\200\200\200 \312\001\010/default\"\017\037\000\205\002\203\002\034column0/*\007column02qptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud:\024\n\017_LiteralTimeout\022\0010:\022\n\r_TableTimeout\022\0010:\037\n\025_AllResultsBytesLimit\022\006100000:\032\n\022_RowsLimitPerWrite\022\0041000:\027\n\022EnableComputeActor\022\0011:\016\n\014WorkerFilter:\031\n\020ComputeActorType\022\005async:\031\n\016WatermarksMode\022\007disable:\037\n\027WatermarksGranularityMs\022\0041000:$\n\034WatermarksLateArrivalDelayMs\022\0045000:\027\n\022EnableChannelStats\022\0011:\020\n\013ExportStats\022\0011be\010\001\022a\037\000\005\205\006\213\000\205\000\204\205\002\203\002\034column0\030Inputs(Parameters\034Program\013\213\000)\251\000?\002\014Arg\000\004)\211\002?\010\206?\006 Iterator\000\006\002?\024\005?\006\003?\004\250\001\001\001\002\001/" }
2025-11-11T14:15:50.029108Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1762870569 nanos: 964000000 } } SUCCESS
2025-11-11T14:15:50.029135Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92, Got CP::PingTaskResponse
2025-11-11T14:15:50.029453Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92 Ping response success: { expired_at { seconds: 1762870569 nanos: 964000000 } }
2025-11-11T14:15:50.029473Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92 Forward request Private::PingTask
2025-11-11T14:15:50.029486Z :FQ_RUN_ACTOR TRACE: run_actor.cpp:861: QueryId: ptqudslmrhta5v3oppmv Forward ping response. Success: 1. Cookie: 2
2025-11-11T14:15:50.029876Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92, Request CP::PingTask with size: 123 bytes
2025-11-11T14:15:50.029956Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "7645876b-61afea9c-2673eaf9-2d459ee92"
query_id {
  value: "ptqudslmrhta5v3oppmv"
}
status: RUNNING
resources {
  rate_limiter: PREPARE
  compilation: PREPARE
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1762956949
  nanos: 788816000
}
tenant: "/default"
}
2025-11-11T14:15:50.039120Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1762870570 nanos: 34000000 } } SUCCESS
2025-11-11T14:15:50.039168Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92, Got CP::PingTaskResponse
2025-11-11T14:15:50.039487Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92 Ping response success: { expired_at { seconds: 1762870570 nanos: 34000000 } }
2025-11-11T14:15:50.039507Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92 Forward request Private::PingTask
2025-11-11T14:15:50.039528Z :FQ_RUN_ACTOR TRACE: run_actor.cpp:861: QueryId: ptqudslmrhta5v3oppmv Forward ping response. Success: 1. Cookie: 0
2025-11-11T14:15:50.039966Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92, Request CP::PingTask with size: 192 bytes
2025-11-11T14:15:50.040070Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "7645876b-61afea9c-2673eaf9-2d459ee92"
query_id {
  value: "ptqudslmrhta5v3oppmv"
}
status: RUNNING
resources {
  rate_limiter: READY
  compilation: PREPARE
  rate_limiter_path: "local/RateLimiter_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/rate_limiter"
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1762956949
  nanos: 788816000
}
tenant: "/default"
}
2025-11-11T14:15:50.048016Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
2025-11-11T14:15:50.048062Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:313: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7571471361138010875:2199]
2025-11-11T14:15:50.048086Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:375: Cloud id: mock_cloud Folder id: my_folder
2025-11-11T14:15:50.048129Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
2025-11-11T14:15:50.048182Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:176: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7571471361138010876:2200]
2025-11-11T14:15:50.048211Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:237: Subject Type: federated_account Token: **** (B6C6F477)
2025-11-11T14:15:50.048234Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
2025-11-11T14:15:50.048256Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:69: Request actor. Actor id: [1:7571471361138010877:2201]
2025-11-11T14:15:50.048302Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudslmrhta5v3oppmv"
} [root@builtin, **** (B6C6F477)] 
2025-11-11T14:15:50.050348Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1762870570 nanos: 46000000 } } SUCCESS
2025-11-11T14:15:50.050384Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92, Got CP::PingTaskResponse
2025-11-11T14:15:50.050515Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudslmrhta5v3oppmv" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1762870549 nanos: 370576000 } modified_at { seconds: 1762870549 nanos: 370576000 } revision: 1 } started_at { seconds: 1762870549 nanos: 845000000 } execute_mode: RUN status: RUNNING last_job_query_revision: 1 last_job_id: "ptjudslmrhta4nukmvna-ptqudslmrhta5v3oppmv" started_by: "root@builtin" submitted_at { seconds: 1762870549 nanos: 370576000 } } content { type: STREAMING name: "q" acl { visibility: PRIVATE } limits { execution_timeout { } } text: "SELECT 42;" syntax: YQL_V1 } } } SUCCESS
2025-11-11T14:15:50.050714Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92 Ping response success: { expired_at { seconds: 1762870570 nanos: 46000000 } }
2025-11-11T14:15:50.050735Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92 Forward request Private::PingTask
2025-11-11T14:15:50.050746Z :FQ_RUN_ACTOR TRACE: run_actor.cpp:861: QueryId: ptqudslmrhta5v3oppmv Forward ping response. Success: 1. Cookie: 0
2025-11-11T14:15:50.051174Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92, Request CP::PingTask with size: 598 bytes
2025-11-11T14:15:50.051257Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "7645876b-61afea9c-2673eaf9-2d459ee92"
query_id {
  value: "ptqudslmrhta5v3oppmv"
}
ast: "(\n(let $1 (Configure! world (DataSource \'\"config\") \'\"DqEngine\" \'\"force\"))\n(let $2 (DataSink \'result))\n(let $3 \'(\'(\'type) \'(\'autoref) \'(\'columns \'(\'\"column0\"))))\n(let $4 (ResFill! $1 $2 (Key) (AsList (AsStruct \'(\'\"column0\" (Int32 \'\"42\")))) $3 \'\"dq\"))\n(return (Commit! $4 $2))\n)\n"
plan: "{\"Detailed\":{\"Operations\":[{\"Id\":2,\"Name\":\"ResFill!\"}],\"OperationRoot\":2,\"Providers\":[],\"OperationStats\":{\"ResFill!\":1}},\"Basic\":{\"nodes\":[{\"id\":2,\"level\":1,\"name\":\"ResFill!\",\"type\":\"op\"}],\"links\":[]}}"
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1762956949
  nanos: 788816000
}
tenant: "/default"
}
2025-11-11T14:15:50.058517Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1762870570 nanos: 54000000 } } SUCCESS
2025-11-11T14:15:50.058550Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92, Got CP::PingTaskResponse
2025-11-11T14:15:50.058933Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92 Ping response success: { expired_at { seconds: 1762870570 nanos: 54000000 } }
2025-11-11T14:15:50.058964Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92 Forward request Private::PingTask
2025-11-11T14:15:50.058978Z :FQ_RUN_ACTOR TRACE: run_actor.cpp:861: QueryId: ptqudslmrhta5v3oppmv Forward ping response. Success: 1. Cookie: 0
2025-11-11T14:15:50.059449Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92, Request CP::PingTask with size: 1031 bytes
2025-11-11T14:15:50.059547Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "7645876b-61afea9c-2673eaf9-2d459ee92"
query_id {
  value: "ptqudslmrhta5v3oppmv"
}
result_set_count: 1
result_set_meta {
  column {
    name: "column0"
    type {
      type_id: INT32
    }
  }
}
dq_graph: "\022\320\002\010\001\022\024\n\022\t\000\000\000\000\000\000\000\000\021\000\000\000\000\000\000\000\000\032\004\010\240\215\00628\n4\010\001\030\002 \001*\024\n\022\t\000\000\000\000\000\000\000\000\021\000\000\000\000\000\000\000\0002\024\n\022\t\001\000\000\000\000\000\000\000\021\000\000\000\000\001\000\000\000X\001R\000:s\n*type.googleapis.com/Yql.DqsProto.TTaskMeta\022E\010\001\022A\022(8d73c3b672aec01e659c446142c7a17d47fb7b86\032\023dq_vanilla_job.lite \002H\001RClocal/RateLimiter_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/rate_limiterZ)mock_cloud/my_folder/ptqudslmrhta5v3oppmv`\200\200\200\200 \312\001\010/default\"\017\037\000\205\002\203\002\034column0/*\007column02qptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud:\024\n\017_LiteralTimeout\022\0010:\022\n\r_TableTimeout\022\0010:\037\n\025_AllResultsBytesLimit\022\006100000:\032\n\022_RowsLimitPerWrite\022\0041000:\027\n\022EnableComputeActor\022\0011:\016\n\014WorkerFilter:\031\n\020ComputeActorType\022\005async:\031\n\016WatermarksMode\022\007disable:\037\n\027WatermarksGranularityMs\022\0041000:$\n\034WatermarksLateArrivalDelayMs\022\0045000:\027\n\022EnableChannelStats\022\0011:\020\n\013ExportStats\022\0011be\010\001\022a\037\000\005\205\006\213\000\205\000\204\205\002\203\002\034column0\030Inputs(Parameters\034Program\013\213\000)\251\000?\002\014Arg\000\004)\211\002?\010\206?\006 Iterator\000\006\002?\024\005?\006\003?\004\250\001\001\001\002\001/"
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1762956949
  nanos: 788816000
}
tenant: "/default"
}
2025-11-11T14:15:50.068058Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1762870570 nanos: 63000000 } } SUCCESS
2025-11-11T14:15:50.068087Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92, Got CP::PingTaskResponse
2025-11-11T14:15:50.068427Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92 Ping response success: { expired_at { seconds: 1762870570 nanos: 63000000 } }
2025-11-11T14:15:50.068464Z :FQ_RUN_ACTOR TRACE: run_actor.cpp:861: QueryId: ptqudslmrhta5v3oppmv Forward ping response. Success: 1. Cookie: 1
2025-11-11T14:15:50.068480Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:911: QueryId: ptqudslmrhta5v3oppmv Overall dq tasks: 1
2025-11-11T14:15:50.068541Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92 Forward ping request: { owner_id: "7645876b-61afea9c-2673eaf9-2d459ee92" query_id { value: "ptqudslmrhta5v3oppmv" } status: RUNNING result_set_count: 1 result_set_meta { column { name: "column0" type { type_id: INT32 } } } resources { rate_limiter: READY compilation: READY topic_consumers_state: NOT_NEEDED rate_limiter_path: "local/RateLimiter_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/rate_limiter" } scope: "yandexcloud://my_folder" }
2025-11-11T14:15:50.068556Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92 Forward request Private::PingTask
2025-11-11T14:15:50.068708Z :FQ_RESULT_WRITER INFO: result_writer.cpp:62: TraceId: ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud Bootstrap
2025-11-11T14:15:50.068794Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:50.068 DEBUG ydbd(pid=927307, tid=0x00007F7778D3F640) [DQ] task_controller_impl.h:83: _AllResultsBytesLimit = 100000
2025-11-11T14:15:50.068811Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:50.068 DEBUG ydbd(pid=927307, tid=0x00007F7778D3F640) [DQ] task_controller_impl.h:86: _RowsLimitPerWrite = 1000
2025-11-11T14:15:50.068855Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1653: QueryId: ptqudslmrhta5v3oppmv Executer: [1:7571471361138010885:2209], Controller: [1:7571471361138010888:2212], ResultIdActor: [1:7571471361138010886:2210]
2025-11-11T14:15:50.068880Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:50.068 DEBUG ydbd(pid=927307, tid=0x00007F7778D3F640) [DQ] executer_actor.cpp:140: {ptqudslmrhta5v3oppmv} TDqExecuter::OnGraph
2025-11-11T14:15:50.068893Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:50.068 INFO  ydbd(pid=927307, tid=0x00007F7778D3F640) [DQ] executer_actor.cpp:157: {ptqudslmrhta5v3oppmv} Trying to allocate 1 workers [EnableComputeActor=1]
2025-11-11T14:15:50.068956Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92, Request CP::PingTask with size: 213 bytes
2025-11-11T14:15:50.069015Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:50.069 DEBUG ydbd(pid=927307, tid=0x00007F7778D3F640) [DQ] executer_actor.cpp:247: {ptqudslmrhta5v3oppmv} Dq timeouts are set to: 0.000000s (global), 600.000000s (workers allocation fail), 30.000000s (workers allocation warn) 
2025-11-11T14:15:50.069023Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "7645876b-61afea9c-2673eaf9-2d459ee92"
query_id {
  value: "ptqudslmrhta5v3oppmv"
}
status: RUNNING
result_set_count: 1
result_set_meta {
  column {
    name: "column0"
    type {
      type_id: INT32
    }
  }
}
resources {
  rate_limiter: READY
  compilation: READY
  topic_consumers_state: NOT_NEEDED
  rate_limiter_path: "local/RateLimiter_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/rate_limiter"
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1762956949
  nanos: 788816000
}
tenant: "/default"
}
2025-11-11T14:15:50.069904Z :YQL_NODES_MANAGER DEBUG: nodes_manager.cpp:125: TEvAllocateWorkersResponse Nodes {
  ResourceId: 4294967297
  Worker {
    NodeId: 1
    Guid: "4175c08c-4e2d972f-f8fe069c-a191640f,ghrun-vb3yoermsa"
  }
}
2025-11-11T14:15:50.070183Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:134: SelfId: [1:7571471361138010893:2217], TxId: ptqudslmrhta5v3oppmv, task: 1. Ctx: {}. Start compute actor [1:7571471361138010893:2217], task: 1
2025-11-11T14:15:50.070207Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:50.070 DEBUG ydbd(pid=927307, tid=0x00007F7778D3F640) [DQ] executer_actor.cpp:358: {ptqudslmrhta5v3oppmv} TDqExecuter::TEvAllocateWorkersResponse
2025-11-11T14:15:50.070216Z :KQP_COMPUTE DEBUG: dq_async_compute_actor.cpp:113: SelfId: [1:7571471361138010893:2217], TxId: ptqudslmrhta5v3oppmv, task: 1. Ctx: {}. Use CPU quota: 1. Rate limiter resource: { "local/RateLimiter_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/rate_limiter", "mock_cloud/my_folder/ptqudslmrhta5v3oppmv" }
2025-11-11T14:15:50.070225Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:50.070 DEBUG ydbd(pid=927307, tid=0x00007F7778D3F640) [DQ] executer_actor.cpp:384: {ptqudslmrhta5v3oppmv} Allocated resource 4294967297
2025-11-11T14:15:50.070252Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:50.070 DEBUG ydbd(pid=927307, tid=0x00007F7778D3F640) [DQ] executer_actor.cpp:401: {ptqudslmrhta5v3oppmv} WorkerInfo: Id:4175c08c-4e2d972f-f8fe069c-a191640f,ghrun-vb3yoermsa,NodeId:1,StageId:1
2025-11-11T14:15:50.070264Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:50.070 DEBUG ydbd(pid=927307, tid=0x00007F7778D3F640) [DQ] executer_actor.cpp:402: {ptqudslmrhta5v3oppmv} TaskInfo: 0/1
2025-11-11T14:15:50.070271Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:50.070 DEBUG ydbd(pid=927307, tid=0x00007F7778D3F640) [DQ] executer_actor.cpp:404: {ptqudslmrhta5v3oppmv}  ObjectId: 8d73c3b672aec01e659c446142c7a17d47fb7b86, dq_vanilla_job.lite, 
2025-11-11T14:15:50.070285Z :YQL_PROXY INFO: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:50.070 INFO  ydbd(pid=927307, tid=0x00007F7778D3F640) [DQ] executer_actor.cpp:415: {ptqudslmrhta5v3oppmv} 1 workers allocated
2025-11-11T14:15:50.070289Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 7645876b-61afea9c-2673eaf9-2d459ee9 2025-11-11 14:15:50.070 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [DQ] tasks_runner_local.cpp:267: {TODO/1} Build task: 1
2025-11-11T14:15:50.070342Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 7645876b-61afea9c-2673eaf9-2d459ee9 2025-11-11 14:15:50.070 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [DQ] tasks_runner_local.cpp:267: {TODO/1} task: 1, program size: 10, llvm: ``.
2025-11-11T14:15:50.070389Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud 2025-11-11 14:15:50.070 TRACE ydbd(pid=927307, tid=0x00007F777753C640) [DQ] task_controller_impl.h:271: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud}  [1:7571471361138010888:2212] ExportStats Summary
2025-11-11T14:15:50.070425Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud 2025-11-11 14:15:50.070 DEBUG ydbd(pid=927307, tid=0x00007F777753C640) [DQ] task_controller_impl.h:526: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Ready State: [1:7571471361138010888:2212]
2025-11-11T14:15:50.070441Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud 2025-11-11 14:15:50.070 DEBUG ydbd(pid=927307, tid=0x00007F777753C640) [DQ] task_controller_impl.h:537: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Forward: [1:7571471361138010888:2212] to [1:7571471361138010887:2211]
2025-11-11T14:15:50.070473Z :STREAMS_CHECKPOINT_COORDINATOR DEBUG: checkpoint_coordinator.cpp:70: [ptqudslmrhta5v3oppmv-0.1] TEvReadyState, streaming disposition { fresh { } }, state load mode EMPTY, checkpointing period 1.000000s
2025-11-11T14:15:50.070487Z :STREAMS_CHECKPOINT_COORDINATOR DEBUG: checkpoint_coordinator.cpp:104: [ptqudslmrhta5v3oppmv-0.1] AllActors count: 1, ActorsToTrigger count: 0, ActorsToNotify count: 0, ActorsToWaitFor count: 0
2025-11-11T14:15:50.070489Z :STREAMS_CHECKPOINT_COORDINATOR DEBUG: checkpoint_coordinator.cpp:107: [ptqudslmrhta5v3oppmv-0.1] No ingress tasks, coordinator was disabled
2025-11-11T14:15:50.070492Z :STREAMS_CHECKPOINT_COORDINATOR INFO: checkpoint_coordinator.cpp:445: [ptqudslmrhta5v3oppmv-0.1] Send TEvRun to all actors
2025-11-11T14:15:50.072636Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 7645876b-61afea9c-2673eaf9-2d459ee9 2025-11-11 14:15:50.072 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [DQ] tasks_runner_local.cpp:267: {TODO/1} Build task: 1 takes 2319 us
2025-11-11T14:15:50.072655Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 7645876b-61afea9c-2673eaf9-2d459ee9 2025-11-11 14:15:50.072 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [DQ] tasks_runner_local.cpp:267: {TODO/1} Prepare task: 1
2025-11-11T14:15:50.072672Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 7645876b-61afea9c-2673eaf9-2d459ee9 2025-11-11 14:15:50.072 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [DQ] tasks_runner_local.cpp:267: {TODO/1} Prepare task: 1, takes 10 us
2025-11-11T14:15:50.072714Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:1174: SelfId: [1:7571471361138010893:2217], TxId: ptqudslmrhta5v3oppmv, task: 1. Ctx: {}. Got TEvRun from actor [1:7571471361138010887:2211]
2025-11-11T14:15:50.072728Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1491: SelfId: [1:7571471361138010893:2217], TxId: ptqudslmrhta5v3oppmv, task: 1. Ctx: {}. Poll inputs
2025-11-11T14:15:50.072729Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1506: SelfId: [1:7571471361138010893:2217], TxId: ptqudslmrhta5v3oppmv, task: 1. Ctx: {}. Poll sources
2025-11-11T14:15:50.072731Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:694: SelfId: [1:7571471361138010893:2217], TxId: ptqudslmrhta5v3oppmv, task: 1. Ctx: {}. DoExecuteImpl: 0
2025-11-11T14:15:50.072743Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 7645876b-61afea9c-2673eaf9-2d459ee9 2025-11-11 14:15:50.072 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [DQ] tasks_runner_local.cpp:267: {TODO/1} Run task: 1
2025-11-11T14:15:50.072755Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud 2025-11-11 14:15:50.072 TRACE ydbd(pid=927307, tid=0x00007F7778D3F640) [DQ] task_controller_impl.h:160: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} [1:7571471361138010888:2212] EvState TaskId: 1 State: 2 PingCookie: 0 StatusCode: UNSPECIFIED
2025-11-11T14:15:50.072767Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud 2025-11-11 14:15:50.072 TRACE ydbd(pid=927307, tid=0x00007F7778D3F640) [DQ] task_controller_impl.h:201: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud}  [1:7571471361138010888:2212] Executing TaskId: 1
2025-11-11T14:15:50.072774Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 7645876b-61afea9c-2673eaf9-2d459ee9 2025-11-11 14:15:50.072 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [DQ] tasks_runner_local.cpp:267: {TODO/1} task1, execution finished, finish consumers
2025-11-11T14:15:50.072782Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 7645876b-61afea9c-2673eaf9-2d459ee9 2025-11-11 14:15:50.072 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [DQ] tasks_runner_local.cpp:267: {TODO/1} channelId: 1. Finish request
2025-11-11T14:15:50.072793Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud 2025-11-11 14:15:50.072 DEBUG ydbd(pid=927307, tid=0x00007F7778D3F640) [DQ] task_controller_impl.h:561: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} Update channels
2025-11-11T14:15:50.072796Z :KQP_COMPUTE TRACE: dq_compute_memory_quota.h:97: TxId: ptqudslmrhta5v3oppmv, task: 1. Peak memory usage: 196608
2025-11-11T14:15:50.072803Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:491: SelfId: [1:7571471361138010893:2217], TxId: ptqudslmrhta5v3oppmv, task: 1. Ctx: {}. update task runner stats
2025-11-11T14:15:50.072819Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:758: SelfId: [1:7571471361138010893:2217], TxId: ptqudslmrhta5v3oppmv, task: 1. Ctx: {}. Resume execution, run status: Finished checkpoint: 0 watermark injected: (empty maybe)
2025-11-11T14:15:50.072823Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:393: SelfId: [1:7571471361138010893:2217], TxId: ptqudslmrhta5v3oppmv, task: 1. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-11-11T14:15:50.072825Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:409: SelfId: [1:7571471361138010893:2217], TxId: ptqudslmrhta5v3oppmv, task: 1. Ctx: {}. Can not drain channelId: 1, no dst actor id
2025-11-11T14:15:50.072829Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:502: SelfId: [1:7571471361138010893:2217], TxId: ptqudslmrhta5v3oppmv, task: 1. Ctx: {}. Continue execution, either output buffers are not empty or not all channels are ready, hasDataToSend: 1, channelsReady: 0
2025-11-11T14:15:50.074180Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud 2025-11-11 14:15:50.072 TRACE ydbd(pid=927307, tid=0x00007F7778D3F640) [DQ] task_controller_impl.h:577: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} 1 Update { Id: 1 SrcTaskId: 2 DstTaskId: 1 SrcEndpoint { ActorId { RawX1: 0 RawX2: 0 } } DstEndpoint { ActorId { RawX1: 7571471361138010886 RawX2: 4503603922340002 } } SrcStageId: 1 }
2025-11-11T14:15:50.074215Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:1074: SelfId: [1:7571471361138010893:2217], TxId: ptqudslmrhta5v3oppmv, task: 1. Ctx: {}. Received channels info: Update { Id: 1 SrcTaskId: 2 DstTaskId: 1 SrcEndpoint { ActorId { RawX1: 0 RawX2: 0 } } DstEndpoint { ActorId { RawX1: 7571471361138010886 RawX2: 4503603922340002 } } SrcStageId: 1 }
2025-11-11T14:15:50.074218Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:1093: SelfId: [1:7571471361138010893:2217], TxId: ptqudslmrhta5v3oppmv, task: 1. Ctx: {}. Update output channelId: 1, peer: [1:7571471361138010886:2210]
2025-11-11T14:15:50.074223Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1491: SelfId: [1:7571471361138010893:2217], TxId: ptqudslmrhta5v3oppmv, task: 1. Ctx: {}. Poll inputs
2025-11-11T14:15:50.074225Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1506: SelfId: [1:7571471361138010893:2217], TxId: ptqudslmrhta5v3oppmv, task: 1. Ctx: {}. Poll sources
2025-11-11T14:15:50.074226Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:694: SelfId: [1:7571471361138010893:2217], TxId: ptqudslmrhta5v3oppmv, task: 1. Ctx: {}. DoExecuteImpl: 0
2025-11-11T14:15:50.074268Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:491: SelfId: [1:7571471361138010893:2217], TxId: ptqudslmrhta5v3oppmv, task: 1. Ctx: {}. update task runner stats
2025-11-11T14:15:50.074287Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:758: SelfId: [1:7571471361138010893:2217], TxId: ptqudslmrhta5v3oppmv, task: 1. Ctx: {}. Resume execution, run status: Finished checkpoint: 0 watermark injected: (empty maybe)
2025-11-11T14:15:50.074293Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:393: SelfId: [1:7571471361138010893:2217], TxId: ptqudslmrhta5v3oppmv, task: 1. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-11-11T14:15:50.074299Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:532: SelfId: [1:7571471361138010893:2217], TxId: ptqudslmrhta5v3oppmv, task: 1. Ctx: {}. About to drain channelId: 1, hasPeer: 1, peerState:(freeSpace:1000000;inFlightBytes:0;inFlightCount:0;)
2025-11-11T14:15:50.074331Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:566: TxId: ptqudslmrhta5v3oppmv, task: 1. SendChannelData, channelId: 1, peer: [1:7571471361138010886:2210], chunks: 1, bytes: 3, watermark: 0, checkpoint: 0, seqNo: 1, finished: 1
2025-11-11T14:15:50.074348Z :KQP_COMPUTE DEBUG: dq_compute_actor_channels.cpp:669: TxId: ptqudslmrhta5v3oppmv, task: 1. Tasks execution finished, waiting for chunk delivery in output channelId: 1, seqNo: [1]
2025-11-11T14:15:50.074831Z :YQL_PRIVATE_PROXY DEBUG: task_result_write.cpp:79: PrivateWriteTask - ResultId: ptrudslmrheq7v6kdmu0, RequestId: 0,  Request CP::WriteTaskResult with size: 102 bytes
2025-11-11T14:15:50.074850Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_result_write.cpp:33: WriteResultDataRequest: ptrudslmrheq7v6kdmu0 0 0 24 2025-11-12T14:15:49.788816Z
2025-11-11T14:15:50.086138Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1762870570 nanos: 81000000 } } SUCCESS
2025-11-11T14:15:50.086172Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92, Got CP::PingTaskResponse
2025-11-11T14:15:50.086500Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92 Ping response success: { expired_at { seconds: 1762870570 nanos: 81000000 } }
2025-11-11T14:15:50.086529Z :FQ_RUN_ACTOR TRACE: run_actor.cpp:861: QueryId: ptqudslmrhta5v3oppmv Forward ping response. Success: 1. Cookie: 0
2025-11-11T14:15:50.094226Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: WriteResultDataRequest - WriteResultDataResult: {} SUCCESS
2025-11-11T14:15:50.094257Z :YQL_PRIVATE_PROXY DEBUG: task_result_write.cpp:94: PrivateWriteTask - ResultId: ptrudslmrheq7v6kdmu0, RequestId: 0,  Got CP::WriteTaskResult Response
2025-11-11T14:15:50.094644Z :FQ_RESULT_WRITER TRACE: result_writer.cpp:175: TraceId: ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud ChannelData, Records: 1 HasError: 0 Size: 3 Rows: 1 FreeSpace: 67108864 Duration: 0.025948s AvgSpeed: 0
2025-11-11T14:15:50.094655Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:179: TxId: ptqudslmrhta5v3oppmv, task: 1. Received channel data ack for channelId: 1, seqNo: 1, lastSentSeqNo: 1, freeSpace: 67108864, early finish: 0
2025-11-11T14:15:50.094663Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:207: TxId: ptqudslmrhta5v3oppmv, task: 1. PeerState, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;), sentSeqNo: 1, ackSeqNo: 1
2025-11-11T14:15:50.094664Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:220: TxId: ptqudslmrhta5v3oppmv, task: 1. Resume compute actor
2025-11-11T14:15:50.094677Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1491: SelfId: [1:7571471361138010893:2217], TxId: ptqudslmrhta5v3oppmv, task: 1. Ctx: {}. Poll inputs
2025-11-11T14:15:50.094679Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1506: SelfId: [1:7571471361138010893:2217], TxId: ptqudslmrhta5v3oppmv, task: 1. Ctx: {}. Poll sources
2025-11-11T14:15:50.094681Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:694: SelfId: [1:7571471361138010893:2217], TxId: ptqudslmrhta5v3oppmv, task: 1. Ctx: {}. DoExecuteImpl: 0
2025-11-11T14:15:50.094733Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 7645876b-61afea9c-2673eaf9-2d459ee9 2025-11-11 14:15:50.094 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [DQ] tasks_runner_local.cpp:267: {TODO/1} Run task: 1
2025-11-11T14:15:50.094752Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 7645876b-61afea9c-2673eaf9-2d459ee9 2025-11-11 14:15:50.094 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [DQ] tasks_runner_local.cpp:267: {TODO/1} task1, execution finished, finish consumers
2025-11-11T14:15:50.094759Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: 7645876b-61afea9c-2673eaf9-2d459ee9 2025-11-11 14:15:50.094 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [DQ] tasks_runner_local.cpp:267: {TODO/1} channelId: 1. Finish request
2025-11-11T14:15:50.094774Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:491: SelfId: [1:7571471361138010893:2217], TxId: ptqudslmrhta5v3oppmv, task: 1. Ctx: {}. update task runner stats
2025-11-11T14:15:50.094799Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:758: SelfId: [1:7571471361138010893:2217], TxId: ptqudslmrhta5v3oppmv, task: 1. Ctx: {}. Resume execution, run status: Finished checkpoint: 0 watermark injected: (empty maybe)
2025-11-11T14:15:50.094805Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:393: SelfId: [1:7571471361138010893:2217], TxId: ptqudslmrhta5v3oppmv, task: 1. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-11-11T14:15:50.094807Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:423: SelfId: [1:7571471361138010893:2217], TxId: ptqudslmrhta5v3oppmv, task: 1. Ctx: {}. Do not drain channelId: 1, finished
2025-11-11T14:15:50.094812Z :KQP_COMPUTE DEBUG: dq_compute_actor_channels.cpp:674: TxId: ptqudslmrhta5v3oppmv, task: 1. Tasks execution finished
2025-11-11T14:15:50.094814Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:510: SelfId: [1:7571471361138010893:2217], TxId: ptqudslmrhta5v3oppmv, task: 1. Ctx: {}. Compute state finished. All channels and sinks finished
2025-11-11T14:15:50.094831Z :KQP_COMPUTE DEBUG: dq_compute_actor_channels.cpp:494: TxId: ptqudslmrhta5v3oppmv, task: 1. pass away
2025-11-11T14:15:50.094869Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud 2025-11-11 14:15:50.094 TRACE ydbd(pid=927307, tid=0x00007F7778D3F640) [DQ] task_controller_impl.h:160: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud} [1:7571471361138010888:2212] EvState TaskId: 1 State: 3 PingCookie: 0 StatusCode: SUCCESS
2025-11-11T14:15:50.094887Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud 2025-11-11 14:15:50.094 TRACE ydbd(pid=927307, tid=0x00007F7778D3F640) [DQ] task_controller_impl.h:174: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud}  [1:7571471361138010888:2212] AddStats 1
2025-11-11T14:15:50.094960Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud 2025-11-11 14:15:50.094 DEBUG ydbd(pid=927307, tid=0x00007F7778D3F640) [DQ] task_controller_impl.h:212: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud}  [1:7571471361138010888:2212] Finish TaskId: 1. Tasks finished: 1/1
2025-11-11T14:15:50.095092Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud 2025-11-11 14:15:50.095 TRACE ydbd(pid=927307, tid=0x00007F7778D3F640) [DQ] task_controller_impl.h:271: {ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud}  [1:7571471361138010888:2212] ExportStats Summary
2025-11-11T14:15:50.095286Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:50.095 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [DQ] executer_actor.cpp:324: {ptqudslmrhta5v3oppmv} OnGraphFinished
2025-11-11T14:15:50.095296Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:50.095 DEBUG ydbd(pid=927307, tid=0x00007F7777D3D640) [DQ] executer_actor.cpp:284: {ptqudslmrhta5v3oppmv} Finish with status=1 issues=
2025-11-11T14:15:50.095453Z :FQ_RESULT_WRITER DEBUG: result_writer.cpp:126: TraceId: ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud Send response to executer
2025-11-11T14:15:50.095492Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:50.095 DEBUG ydbd(pid=927307, tid=0x00007F7778D3F640) [DQ] executer_actor.cpp:341: {ptqudslmrhta5v3oppmv} OnQueryResponse status=1 issuses_size=0
2025-11-11T14:15:50.095519Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1234: QueryId: ptqudslmrhta5v3oppmv Query response SUCCESS. Result set index: 0. Issues count: 0. Rows count: 1
2025-11-11T14:15:50.095540Z :FQ_RESULT_WRITER INFO: result_writer.cpp:87: TraceId: ptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud FinishWrite, Records: 1 HasError: 0 Size: 3 Rows: 1 FreeSpace: 67108864 Duration: 0.026847s AvgSpeed: 0 ResultChunks.size(): 0
2025-11-11T14:15:50.095882Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1827: QueryId: ptqudslmrhta5v3oppmv Is about to finish query with status COMPLETED
2025-11-11T14:15:50.095890Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1820: QueryId: ptqudslmrhta5v3oppmv Write finalizing status: COMPLETING
2025-11-11T14:15:50.095892Z :STREAMS_CHECKPOINT_COORDINATOR DEBUG: checkpoint_coordinator.cpp:657: [ptqudslmrhta5v3oppmv-0.1] PassAway
2025-11-11T14:15:50.095929Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92 Forward ping request: { status: COMPLETING }
2025-11-11T14:15:50.095936Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92 Forward request Private::PingTask
2025-11-11T14:15:50.096354Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92, Request CP::PingTask with size: 116 bytes
2025-11-11T14:15:50.096449Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "7645876b-61afea9c-2673eaf9-2d459ee92"
query_id {
  value: "ptqudslmrhta5v3oppmv"
}
status: COMPLETING
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1762956949
  nanos: 788816000
}
tenant: "/default"
}
2025-11-11T14:15:50.104512Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1762870570 nanos: 100000000 } } SUCCESS
2025-11-11T14:15:50.104556Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92, Got CP::PingTaskResponse
2025-11-11T14:15:50.104909Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92 Ping response success: { expired_at { seconds: 1762870570 nanos: 100000000 } }
2025-11-11T14:15:50.104930Z :FQ_RUN_ACTOR TRACE: run_actor.cpp:880: QueryId: ptqudslmrhta5v3oppmv Forward ping response. Success: 1. Cookie: 3
2025-11-11T14:15:50.104931Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:887: QueryId: ptqudslmrhta5v3oppmv Finalizing status is saved
2025-11-11T14:15:50.104934Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1508: QueryId: ptqudslmrhta5v3oppmv Start rate limiter resource deleter
2025-11-11T14:15:50.105434Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:175: PrivateDeleteRateLimiterResource - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92, Request CP::DeleteRateLimiterResource with size: 97 bytes
2025-11-11T14:15:50.105499Z :YQ_CONTROL_PLANE_STORAGE TRACE: request_actor.h:57: DeleteRateLimiterResourceRequest: {owner_id: "7645876b-61afea9c-2673eaf9-2d459ee92"
query_id {
  value: "ptqudslmrhta5v3oppmv"
}
scope: "yandexcloud://my_folder"
tenant: "/default"
} 
2025-11-11T14:15:50.135404Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:74: DeleteRateLimiterResourceRequest. Got response from database: SUCCESS
2025-11-11T14:15:50.135488Z :YQ_RATE_LIMITER DEBUG: schema.cpp:71: Run delete rate limiter resource "mock_cloud/my_folder/ptqudslmrhta5v3oppmv" actor
2025-11-11T14:15:50.135496Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call delete rate limiter resource "mock_cloud/my_folder/ptqudslmrhta5v3oppmv"
2025-11-11T14:15:50.138098Z :YQ_RATE_LIMITER DEBUG: schema.cpp:179: Successfully deleted rate limiter resource "mock_cloud/my_folder/ptqudslmrhta5v3oppmv"
2025-11-11T14:15:50.138108Z :YQ_RATE_LIMITER DEBUG: schema.cpp:122: Reply for delete rate limiter resource "mock_cloud/my_folder/ptqudslmrhta5v3oppmv": 
2025-11-11T14:15:50.138138Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:219: Got delete response from rate limiter service
2025-11-11T14:15:50.138159Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:199: PrivateDeleteRateLimiterResource - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92, Got CP::DeleteRateLimiterResourceResponse
2025-11-11T14:15:50.138523Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1499: QueryId: ptqudslmrhta5v3oppmv Rate limiter resource deletion finished. Success: 1. Issues: 
2025-11-11T14:15:50.138531Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1919: QueryId: ptqudslmrhta5v3oppmv SendPingAndPassAway, FinalQueryStatus COMPLETED
2025-11-11T14:15:50.138550Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:536: QueryId: ptqudslmrhta5v3oppmv PassAway
2025-11-11T14:15:50.138725Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92 Forward ping request: { owner_id: "7645876b-61afea9c-2673eaf9-2d459ee92" query_id { value: "ptqudslmrhta5v3oppmv" } result_id { value: "ptrudslmrheq7v6kdmu0" } status: COMPLETED result_set_count: 1 statistics: "{\"Graph=0\":{\"Actor\":{\"ActorCreateTimeUs\":{\"sum\":\"209us\",\"count\":1,\"avg\":\"209us\",\"max\":\"209us\",\"min\":\"209us\"}},\"AllocateWorkersUs\":{\"sum\":\"1ms\",\"count\":1,\"avg\":\"1ms\",\"max\":\"1ms\",\"min\":\"1ms\"},\"ExecutionTimeUs\":{\"sum\":\"25ms\",\"count\":1,\"avg\":\"25ms\",\"max\":\"25ms\",\"min\":\"25ms\"},\"TaskRunner\":{\"Output=0\":{\"Stage=1\":{\"PopBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"PopChunks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PopFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:50.07s\",\"max\":\"14:15:50.07s\",\"min\":\"14:15:50.07s\"},\"PopLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:50.07s\",\"max\":\"14:15:50.07s\",\"min\":\"14:15:50.07s\"},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PushChunks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PushFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:50.07s\",\"max\":\"14:15:50.07s\",\"min\":\"14:15:50.07s\"},\"PushLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:50.07s\",\"max\":\"14:15:50.07s\",\"min\":\"14:15:50.07s\"},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}}},\"Output=Total\":{\"Stage=1\":{\"ChannelCount\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PopBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"PopChunks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PopFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:50.07s\",\"max\":\"14:15:50.07s\",\"min\":\"14:15:50.07s\"},\"PopLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:50.07s\",\"max\":\"14:15:50.07s\",\"min\":\"14:15:50.07s\"},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PushChunks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PushFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:50.07s\",\"max\":\"14:15:50.07s\",\"min\":\"14:15:50.07s\"},\"PushLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:50.07s\",\"max\":\"14:15:50.07s\",\"min\":\"14:15:50.07s\"},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}},\"Stage=Total\":{\"ChannelCount\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PopBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"PopChunks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PopFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:50.07s\",\"max\":\"14:15:50.07s\",\"min\":\"14:15:50.07s\"},\"PopLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:50.07s\",\"max\":\"14:15:50.07s\",\"min\":\"14:15:50.07s\"},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PushChunks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PushFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:50.07s\",\"max\":\"14:15:50.07s\",\"min\":\"14:15:50.07s\"},\"PushLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:50.07s\",\"max\":\"14:15:50.07s\",\"min\":\"14:15:50.07s\"},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}}},\"Stage=1\":{\"BuildCpuTimeUs\":{\"sum\":\"2ms\",\"count\":1,\"avg\":\"2ms\",\"max\":\"2ms\",\"min\":\"2ms\"},\"ComputeCpuTimeUs\":{\"sum\":\"55us\",\"count\":1,\"avg\":\"55us\",\"max\":\"55us\",\"min\":\"55us\"},\"CpuTimeUs\":{\"sum\":\"2ms\",\"count\":1,\"avg\":\"2ms\",\"max\":\"2ms\",\"min\":\"2ms\"},\"FinishTimeMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:50.09s\",\"max\":\"14:15:50.09s\",\"min\":\"14:15:50.09s\"},\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MkqlMaxMemoryUsage\":{\"sum\":196608,\"count\":1,\"avg\":196608,\"max\":196608,\"min\":196608},\"MultiHop_EarlyThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MultiHop_LateThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"OutputBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"OutputRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"ResultBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"ResultRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}},\"Stage=Total\":{\"BuildCpuTimeUs\":{\"sum\":\"2ms\",\"count\":1,\"avg\":\"2ms\",\"max\":\"2ms\",\"min\":\"2ms\"},\"ComputeCpuTimeUs\":{\"sum\":\"55us\",\"count\":1,\"avg\":\"55us\",\"max\":\"55us\",\"min\":\"55us\"},\"CpuTimeUs\":{\"sum\":\"2ms\",\"count\":1,\"avg\":\"2ms\",\"max\":\"2ms\",\"min\":\"2ms\"},\"FinishTimeMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:50.09s\",\"max\":\"14:15:50.09s\",\"min\":\"14:15:50.09s\"},\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MkqlMaxMemoryUsage\":{\"sum\":196608,\"count\":1,\"avg\":196608,\"max\":196608,\"min\":196608},\"MultiHop_EarlyThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MultiHop_LateThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"OutputBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"OutputRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"ResultBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"ResultRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}}},\"UniqueWorkers\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}}}" result_set_meta { column { name: "column0" type { type_id: INT32 } } rows_count: 1 } status_code: SUCCESS resources { rate_limiter: READY compilation: READY topic_consumers_state: NOT_NEEDED rate_limiter_path: "local/RateLimiter_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/rate_limiter" } scope: "yandexcloud://my_folder" finished_at { seconds: 1762870550 nanos: 95000000 } }
2025-11-11T14:15:50.138730Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92 Forward request Private::PingTask
2025-11-11T14:15:50.139202Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92, Request CP::PingTask with size: 5640 bytes
2025-11-11T14:15:50.139303Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "7645876b-61afea9c-2673eaf9-2d459ee92"
query_id {
  value: "ptqudslmrhta5v3oppmv"
}
result_id {
  value: "ptrudslmrheq7v6kdmu0"
}
status: COMPLETED
result_set_count: 1
statistics: "{\"Graph=0\":{\"Actor\":{\"ActorCreateTimeUs\":{\"sum\":\"209us\",\"count\":1,\"avg\":\"209us\",\"max\":\"209us\",\"min\":\"209us\"}},\"AllocateWorkersUs\":{\"sum\":\"1ms\",\"count\":1,\"avg\":\"1ms\",\"max\":\"1ms\",\"min\":\"1ms\"},\"ExecutionTimeUs\":{\"sum\":\"25ms\",\"count\":1,\"avg\":\"25ms\",\"max\":\"25ms\",\"min\":\"25ms\"},\"TaskRunner\":{\"Output=0\":{\"Stage=1\":{\"PopBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"PopChunks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PopFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:50.07s\",\"max\":\"14:15:50.07s\",\"min\":\"14:15:50.07s\"},\"PopLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:50.07s\",\"max\":\"14:15:50.07s\",\"min\":\"14:15:50.07s\"},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PushChunks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PushFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:50.07s\",\"max\":\"14:15:50.07s\",\"min\":\"14:15:50.07s\"},\"PushLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:50.07s\",\"max\":\"14:15:50.07s\",\"min\":\"14:15:50.07s\"},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}}},\"Output=Total\":{\"Stage=1\":{\"ChannelCount\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PopBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"PopChunks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PopFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:50.07s\",\"max\":\"14:15:50.07s\",\"min\":\"14:15:50.07s\"},\"PopLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:50.07s\",\"max\":\"14:15:50.07s\",\"min\":\"14:15:50.07s\"},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PushChunks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PushFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:50.07s\",\"max\":\"14:15:50.07s\",\"min\":\"14:15:50.07s\"},\"PushLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:50.07s\",\"max\":\"14:15:50.07s\",\"min\":\"14:15:50.07s\"},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}},\"Stage=Total\":{\"ChannelCount\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PopBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"PopChunks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PopFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:50.07s\",\"max\":\"14:15:50.07s\",\"min\":\"14:15:50.07s\"},\"PopLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:50.07s\",\"max\":\"14:15:50.07s\",\"min\":\"14:15:50.07s\"},\"PopQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PopRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PushChunks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"PushFirstMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:50.07s\",\"max\":\"14:15:50.07s\",\"min\":\"14:15:50.07s\"},\"PushLastMessageMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:50.07s\",\"max\":\"14:15:50.07s\",\"min\":\"14:15:50.07s\"},\"PushQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"PushRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}}},\"Stage=1\":{\"BuildCpuTimeUs\":{\"sum\":\"2ms\",\"count\":1,\"avg\":\"2ms\",\"max\":\"2ms\",\"min\":\"2ms\"},\"ComputeCpuTimeUs\":{\"sum\":\"55us\",\"count\":1,\"avg\":\"55us\",\"max\":\"55us\",\"min\":\"55us\"},\"CpuTimeUs\":{\"sum\":\"2ms\",\"count\":1,\"avg\":\"2ms\",\"max\":\"2ms\",\"min\":\"2ms\"},\"FinishTimeMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:50.09s\",\"max\":\"14:15:50.09s\",\"min\":\"14:15:50.09s\"},\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MkqlMaxMemoryUsage\":{\"sum\":196608,\"count\":1,\"avg\":196608,\"max\":196608,\"min\":196608},\"MultiHop_EarlyThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MultiHop_LateThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"OutputBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"OutputRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"ResultBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"ResultRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}},\"Stage=Total\":{\"BuildCpuTimeUs\":{\"sum\":\"2ms\",\"count\":1,\"avg\":\"2ms\",\"max\":\"2ms\",\"min\":\"2ms\"},\"ComputeCpuTimeUs\":{\"sum\":\"55us\",\"count\":1,\"avg\":\"55us\",\"max\":\"55us\",\"min\":\"55us\"},\"CpuTimeUs\":{\"sum\":\"2ms\",\"count\":1,\"avg\":\"2ms\",\"max\":\"2ms\",\"min\":\"2ms\"},\"FinishTimeMs\":{\"sum\":\"N/A\",\"count\":1,\"avg\":\"14:15:50.09s\",\"max\":\"14:15:50.09s\",\"min\":\"14:15:50.09s\"},\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MkqlMaxMemoryUsage\":{\"sum\":196608,\"count\":1,\"avg\":196608,\"max\":196608,\"min\":196608},\"MultiHop_EarlyThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"MultiHop_LateThrownEventsCount\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"OutputBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"OutputRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"ResultBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"ResultRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}}},\"UniqueWorkers\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1}}}"
result_set_meta {
  column {
    name: "column0"
    type {
      type_id: INT32
    }
  }
  rows_count: 1
}
status_code: SUCCESS
resources {
  rate_limiter: READY
  compilation: READY
  topic_consumers_state: NOT_NEEDED
  rate_limiter_path: "local/RateLimiter_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/rate_limiter"
}
scope: "yandexcloud://my_folder"
finished_at {
  seconds: 1762870550
  nanos: 95000000
}
deadline {
  seconds: 1762956949
  nanos: 788816000
}
tenant: "/default"
}
2025-11-11T14:15:50.208105Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {} SUCCESS
2025-11-11T14:15:50.208131Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92, Got CP::PingTaskResponse
2025-11-11T14:15:50.208416Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92 Ping response success: {  }
2025-11-11T14:15:50.208434Z :FQ_PINGER DEBUG: pinger.cpp:379: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92 Query finished
2025-11-11T14:15:50.208437Z :FQ_PINGER TRACE: pinger.cpp:187: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee92 Stop Pinger
2025-11-11T14:15:50.553086Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
2025-11-11T14:15:50.553139Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:313: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7571471361138010913:2234]
2025-11-11T14:15:50.553174Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:375: Cloud id: mock_cloud Folder id: my_folder
2025-11-11T14:15:50.553207Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
2025-11-11T14:15:50.553254Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:176: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7571471361138010914:2235]
2025-11-11T14:15:50.553279Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:237: Subject Type: federated_account Token: **** (B6C6F477)
2025-11-11T14:15:50.553315Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
2025-11-11T14:15:50.553359Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:69: Request actor. Actor id: [1:7571471361138010915:2236]
2025-11-11T14:15:50.553426Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudslmrhta5v3oppmv"
} [root@builtin, **** (B6C6F477)] 
2025-11-11T14:15:50.556234Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudslmrhta5v3oppmv" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1762870549 nanos: 370576000 } modified_at { seconds: 1762870549 nanos: 370576000 } revision: 1 } started_at { seconds: 1762870549 nanos: 845000000 } finished_at { seconds: 1762870550 nanos: 95000000 } execute_mode: RUN status: COMPLETED last_job_query_revision: 1 last_job_id: "ptjudslmrhta4nukmvna-ptqudslmrhta5v3oppmv" result_expire_at { seconds: 1762956949 nanos: 788816000 } started_by: "root@builtin" submitted_at { seconds: 1762870549 nanos: 370576000 } } content { type: STREAMING name: "q" acl { visibility: PRIVATE } limits { execution_timeout { } } text: "SELECT 42;" syntax: YQL_V1 } plan { json: "{\"Detailed\":{\"Operations\":[{\"Id\":2,\"Name\":\"ResFill!\"}],\"OperationRoot\":2,\"Providers\":[],\"OperationStats\":{\"ResFill!\":1}},\"Basic\":{\"nodes\":[{\"id\":2,\"level\":1,\"name\":\"ResFill!\",\"type\":\"op\"}],\"links\":[]}}" } statistics { json: "{\"Graph=0\":{\"Tasks\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"CpuTimeUs\":{\"sum\":\"2ms\",\"count\":1,\"avg\":\"2ms\",\"max\":\"2ms\",\"min\":\"2ms\"},\"OutputBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"OutputRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"ResultBytes\":{\"sum\":3,\"count\":1,\"avg\":3,\"max\":3,\"min\":3},\"ResultRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"MaxMemoryUsage\":{\"sum\":196608,\"count\":1,\"avg\":196608,\"max\":196608,\"min\":196608},\"IngressQueuedBytes\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":1,\"avg\":0,\"max\":0,\"min\":0}}}" } result_set_meta { column { name: "column0" type { type_id: INT32 } } rows_count: 1 } ast { data: "(\n(let $1 (Configure! world (DataSource \'\"config\") \'\"DqEngine\" \'\"force\"))\n(let $2 (DataSink \'result))\n(let $3 \'(\'(\'type) \'(\'autoref) \'(\'columns \'(\'\"column0\"))))\n(let $4 (ResFill! $1 $2 (Key) (AsList (AsStruct \'(\'\"column0\" (Int32 \'\"42\")))) $3 \'\"dq\"))\n(return (Commit! $4 $2))\n)\n" } } } SUCCESS
2025-11-11T14:15:50.558674Z :TICKET_PARSER DEBUG: ticket_parser_impl.h:1828: Ticket **** (B6C6F477) (ipv6:[::1]:60966) has now valid token of root@builtin
2025-11-11T14:15:50.558801Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:922: ModifyQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
content {
  type: STREAMING
  name: "q"
  acl {
    visibility: PRIVATE
  }
  text: "blablabla"
}
execute_mode: RUN
state_load_mode: EMPTY
2025-11-11T14:15:50.558837Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:313: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7571471361138010919:2239]
2025-11-11T14:15:50.558866Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:375: Cloud id: mock_cloud Folder id: my_folder
2025-11-11T14:15:50.558896Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:92: Get quotas bootstrap. Cloud id: mock_cloud Actor id: [1:7571471361138010920:2240]
2025-11-11T14:15:50.558949Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:493: cloud.mock_cloud{yq.streamingQueryDurationMinutes.count=*/0, yq.queryResult.size=*/20971520, yq.analyticsQuery.count=0/100, yq.analyticsQueryDurationMinutes.count=*/1440, yq.memory.size=*/0, yq.result.size=*/0, yq.cpuPercent.count=0/10000, yq.streamingQuery.count=0/100} SEND QUOTAS
2025-11-11T14:15:50.558964Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:108: Cloud id: mock_cloud Quota count: 8
2025-11-11T14:15:50.558984Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:922: ModifyQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
content {
  type: STREAMING
  name: "q"
  acl {
    visibility: PRIVATE
  }
  text: "blablabla"
}
execute_mode: RUN
state_load_mode: EMPTY
2025-11-11T14:15:50.559030Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:176: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7571471361138010921:2241]
2025-11-11T14:15:50.559058Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:237: Subject Type: federated_account Token: **** (B6C6F477)
2025-11-11T14:15:50.559083Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:922: ModifyQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
content {
  type: STREAMING
  name: "q"
  acl {
    visibility: PRIVATE
  }
  text: "blablabla"
}
execute_mode: RUN
state_load_mode: EMPTY
2025-11-11T14:15:50.559107Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:444: Create database bootstrap. CloudId: mock_cloud Scope: yandexcloud://my_folder Actor id: [1:7571471361138010922:2242]
2025-11-11T14:15:50.559146Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:922: ModifyQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
content {
  type: STREAMING
  name: "q"
  acl {
    visibility: PRIVATE
  }
  text: "blablabla"
}
execute_mode: RUN
state_load_mode: EMPTY
2025-11-11T14:15:50.559178Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:69: Request actor. Actor id: [1:7571471361138010923:2243]
2025-11-11T14:15:50.559240Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:812: ModifyQueryRequest: {query_id: "ptqudslmrhta5v3oppmv"
content {
  type: STREAMING
  name: "q"
  acl {
    visibility: PRIVATE
  }
  text: "blablabla"
}
execute_mode: RUN
state_load_mode: EMPTY
} [root@builtin, **** (B6C6F477)] 
2025-11-11T14:15:50.664451Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:617: RowDispatcher: Send ping to [1:7571471352548076173:2110]
2025-11-11T14:15:50.664473Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1161: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-11-11T14:15:50.664480Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:314: Coordinator: TEvPing received, [1:7571471352548076127:2069]
2025-11-11T14:15:50.664482Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:317: Coordinator: Send TEvPong to [1:7571471352548076127:2069]
2025-11-11T14:15:50.664493Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:623: RowDispatcher: NActors::TEvents::TEvPong
2025-11-11T14:15:50.678789Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 7645876b-61afea9c-2673eaf9-2d459ee94, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:15:50.678790Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:542: Coordinator: Send TEvGetNodesRequest to NodesManager
2025-11-11T14:15:50.678814Z :YQL_NODES_MANAGER DEBUG: nodes_manager.cpp:300: TNodesManagerActor::TEvGetNodesRequest
2025-11-11T14:15:50.678820Z :FQ_ROW_DISPATCHER INFO: coordinator.cpp:573: Coordinator: Updated node info, node count: 0
2025-11-11T14:15:50.679374Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 7645876b-61afea9c-2673eaf9-2d459ee94, Host: ghrun-vb3yoermsa, Tenant: /default, Request CP::GetTask with size: 68 bytes
2025-11-11T14:15:50.679432Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "7645876b-61afea9c-2673eaf9-2d459ee94"
host: "ghrun-vb3yoermsa"
node_id: 1
}
2025-11-11T14:15:50.681865Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-11-11T14:15:50.681895Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 7645876b-61afea9c-2673eaf9-2d459ee94, Host: ghrun-vb3yoermsa, Tenant: /default, Got CP::GetTask Response
2025-11-11T14:15:50.682197Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:15:50.682206Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-11-11T14:15:50.810104Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: ModifyQueryRequest - ModifyQueryResult: {} SUCCESS
2025-11-11T14:15:50.811775Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
2025-11-11T14:15:50.811813Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:313: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7571471361138010930:2249]
2025-11-11T14:15:50.811826Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:375: Cloud id: mock_cloud Folder id: my_folder
2025-11-11T14:15:50.811852Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
2025-11-11T14:15:50.811896Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:176: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7571471361138010931:2250]
2025-11-11T14:15:50.811935Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:237: Subject Type: federated_account Token: **** (B6C6F477)
2025-11-11T14:15:50.811961Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
2025-11-11T14:15:50.811991Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:69: Request actor. Actor id: [1:7571471361138010932:2251]
2025-11-11T14:15:50.812047Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudslmrhta5v3oppmv"
} [root@builtin, **** (B6C6F477)] 
2025-11-11T14:15:50.814113Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudslmrhta5v3oppmv" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1762870549 nanos: 370576000 } modified_at { seconds: 1762870550 nanos: 696149000 } revision: 2 } execute_mode: RUN status: STARTING last_job_query_revision: 2 last_job_id: "ptjudslmrgkrool3bqrv-ptqudslmrhta5v3oppmv" started_by: "root@builtin" submitted_at { seconds: 1762870550 nanos: 696149000 } } content { type: STREAMING name: "q" acl { visibility: PRIVATE } text: "blablabla" } } } SUCCESS
2025-11-11T14:15:51.316016Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
2025-11-11T14:15:51.316067Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:313: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7571471365432978232:2254]
2025-11-11T14:15:51.316092Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:375: Cloud id: mock_cloud Folder id: my_folder
2025-11-11T14:15:51.316121Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
2025-11-11T14:15:51.316168Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:176: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7571471365432978233:2255]
2025-11-11T14:15:51.316193Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:237: Subject Type: federated_account Token: **** (B6C6F477)
2025-11-11T14:15:51.316227Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
2025-11-11T14:15:51.316267Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:69: Request actor. Actor id: [1:7571471365432978234:2256]
2025-11-11T14:15:51.316312Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudslmrhta5v3oppmv"
} [root@builtin, **** (B6C6F477)] 
2025-11-11T14:15:51.318883Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudslmrhta5v3oppmv" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1762870549 nanos: 370576000 } modified_at { seconds: 1762870550 nanos: 696149000 } revision: 2 } execute_mode: RUN status: STARTING last_job_query_revision: 2 last_job_id: "ptjudslmrgkrool3bqrv-ptqudslmrhta5v3oppmv" started_by: "root@builtin" submitted_at { seconds: 1762870550 nanos: 696149000 } } content { type: STREAMING name: "q" acl { visibility: PRIVATE } text: "blablabla" } } } SUCCESS
2025-11-11T14:15:51.679215Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:542: Coordinator: Send TEvGetNodesRequest to NodesManager
2025-11-11T14:15:51.679216Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:15:51.679235Z :YQL_NODES_MANAGER DEBUG: nodes_manager.cpp:300: TNodesManagerActor::TEvGetNodesRequest
2025-11-11T14:15:51.679240Z :FQ_ROW_DISPATCHER INFO: coordinator.cpp:573: Coordinator: Updated node info, node count: 0
2025-11-11T14:15:51.679765Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 7645876b-61afea9c-2673eaf9-2d459ee95, Host: ghrun-vb3yoermsa, Tenant: /default, Request CP::GetTask with size: 68 bytes
2025-11-11T14:15:51.679831Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "7645876b-61afea9c-2673eaf9-2d459ee95"
host: "ghrun-vb3yoermsa"
node_id: 1
}
2025-11-11T14:15:51.682168Z :FQ_CONTROL_PLANE_CONFIG TRACE: control_plane_config.cpp:192: LOADED TenantInfo: State NOT changed
2025-11-11T14:15:51.682298Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:463: Task (Query): ptqudslmrhta5v3oppmv RetryRate: 0 RetryCounter: 0 At: 2025-11-11T14:15:50.696244Z
2025-11-11T14:15:51.688902Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {tasks { query_id { value: "ptqudslmrhta5v3oppmv" } job_id { value: "ptjudslmrgkrool3bqrv" } generation: 2 streaming: true dq_graph: "\022\320\002\010\001\022\024\n\022\t\000\000\000\000\000\000\000\000\021\000\000\000\000\000\000\000\000\032\004\010\240\215\00628\n4\010\001\030\002 \001*\024\n\022\t\000\000\000\000\000\000\000\000\021\000\000\000\000\000\000\000\0002\024\n\022\t\001\000\000\000\000\000\000\000\021\000\000\000\000\001\000\000\000X\001R\000:s\n*type.googleapis.com/Yql.DqsProto.TTaskMeta\022E\010\001\022A\022(8d73c3b672aec01e659c446142c7a17d47fb7b86\032\023dq_vanilla_job.lite \002H\001RClocal/RateLimiter_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/rate_limiterZ)mock_cloud/my_folder/ptqudslmrhta5v3oppmv`\200\200\200\200 \312\001\010/default\"\017\037\000\205\002\203\002\034column0/*\007column02qptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud:\024\n\017_LiteralTimeout\022\0010:\022\n\r_TableTimeout\022\0010:\037\n\025_AllResultsBytesLimit\022\006100000:\032\n\022_RowsLimitPerWrite\022\0041000:\027\n\022EnableComputeActor\022\0011:\016\n\014WorkerFilter:\031\n\020ComputeActorType\022\005async:\031\n\016WatermarksMode\022\007disable:\037\n\027WatermarksGranularityMs\022\0041000:$\n\034WatermarksLateArrivalDelayMs\022\0045000:\027\n\022EnableChannelStats\022\0011:\020\n\013ExportStats\022\0011be\010\001\022a\037\000\005\205\006\213\000\205\000\204\205\002\203\002\034column0\030Inputs(Parameters\034Program\013\213\000)\251\000?\002\014Arg\000\004)\211\002?\010\206?\006 Iterator\000\006\002?\024\005?\006\003?\004\250\001\001\001\002\001/" text: "blablabla" user_token: "root@builtin" user_id: "root@builtin" query_type: STREAMING scope: "yandexcloud://my_folder" execute_mode: RUN state_load_mode: EMPTY status: STARTING sensor_labels { key: "cloud_id" value: "mock_cloud" } sensor_labels { key: "scope" value: "yandexcloud://my_folder" } query_name: "q" deadline { seconds: 1762956951 nanos: 684642000 } disposition { fresh { } } result_limit: 20971520 execution_limit { } request_started_at { } resources { } compute_connection { } result_ttl { seconds: 86400 } request_submitted_at { seconds: 1762870550 nanos: 696149000 } } } SUCCESS
2025-11-11T14:15:51.688984Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 7645876b-61afea9c-2673eaf9-2d459ee95, Host: ghrun-vb3yoermsa, Tenant: /default, Got CP::GetTask Response
2025-11-11T14:15:51.689340Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:15:51.689352Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 1
2025-11-11T14:15:51.689365Z :FQ_PENDING_FETCHER DEBUG: pending_fetcher.cpp:361: NewTask: Scope: yandexcloud://my_folder Id: ptqudslmrhta5v3oppmv UserId: root@builtin AuthToken: **** (B6C6F477)
2025-11-11T14:15:51.689513Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:375: QueryId: ptqudslmrhta5v3oppmv Start run actor. Compute state: STARTING
2025-11-11T14:15:51.689520Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 7645876b-61afea9c-2673eaf9-2d459ee96, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:15:51.689522Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:469: QueryId: ptqudslmrhta5v3oppmv FillConnections
2025-11-11T14:15:51.689545Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:2333: QueryId: ptqudslmrhta5v3oppmv Run actors params: { QueryId: ptqudslmrhta5v3oppmv CloudId: mock_cloud UserId: root@builtin Owner: 7645876b-61afea9c-2673eaf9-2d459ee95 PreviousQueryRevision: 2 Connections: 0 Bindings: 0 AccountIdSignatures: 0 QueryType: STREAMING ExecuteMode: RUN ResultId: ptrudslmrfmhq493qggb StateLoadMode: EMPTY StreamingDisposition: { fresh { } } Status: STARTING DqGraphs: 1 DqGraphIndex: 0 Resource.TopicConsumers: 0 }
2025-11-11T14:15:51.689563Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:571: QueryId: ptqudslmrhta5v3oppmv Start rate limiter resource creator
2025-11-11T14:15:51.689578Z :FQ_PINGER TRACE: pinger.cpp:171: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95 Start Pinger
2025-11-11T14:15:51.689638Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95 Forward ping request: { started_at { seconds: 1762870551 nanos: 689000000 } }
2025-11-11T14:15:51.689646Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95 Forward request Private::PingTask
2025-11-11T14:15:51.689665Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95 Forward ping request: { status: RUNNING resources { rate_limiter: PREPARE compilation: PREPARE } }
2025-11-11T14:15:51.689932Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 7645876b-61afea9c-2673eaf9-2d459ee96, Host: ghrun-vb3yoermsa, Tenant: /default, Request CP::GetTask with size: 68 bytes
2025-11-11T14:15:51.689967Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "7645876b-61afea9c-2673eaf9-2d459ee96"
host: "ghrun-vb3yoermsa"
node_id: 1
}
2025-11-11T14:15:51.690001Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:78: PrivateCreateRateLimiterResource - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95, Request CP::CreateRateLimiterResource with size: 97 bytes
2025-11-11T14:15:51.690027Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95, Request CP::PingTask with size: 129 bytes
2025-11-11T14:15:51.690057Z :YQ_CONTROL_PLANE_STORAGE TRACE: request_actor.h:57: CreateRateLimiterResourceRequest: {owner_id: "7645876b-61afea9c-2673eaf9-2d459ee95"
query_id {
  value: "ptqudslmrhta5v3oppmv"
}
scope: "yandexcloud://my_folder"
tenant: "/default"
} 
2025-11-11T14:15:51.690077Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "7645876b-61afea9c-2673eaf9-2d459ee95"
query_id {
  value: "ptqudslmrhta5v3oppmv"
}
scope: "yandexcloud://my_folder"
started_at {
  seconds: 1762870551
  nanos: 689000000
}
deadline {
  seconds: 1762956951
  nanos: 684642000
}
tenant: "/default"
}
2025-11-11T14:15:51.692190Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-11-11T14:15:51.692229Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 7645876b-61afea9c-2673eaf9-2d459ee96, Host: ghrun-vb3yoermsa, Tenant: /default, Got CP::GetTask Response
2025-11-11T14:15:51.692531Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:15:51.692540Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-11-11T14:15:51.692907Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:74: CreateRateLimiterResourceRequest. Got response from database: SUCCESS
2025-11-11T14:15:51.692999Z :YQ_RATE_LIMITER DEBUG: schema.cpp:71: Run create rate limiter resource "mock_cloud/my_folder/ptqudslmrhta5v3oppmv" actor
2025-11-11T14:15:51.693006Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create rate limiter resource "mock_cloud/my_folder/ptqudslmrhta5v3oppmv"
2025-11-11T14:15:51.695334Z :YQ_RATE_LIMITER DEBUG: schema.cpp:155: Successfully created rate limiter resource "mock_cloud/my_folder/ptqudslmrhta5v3oppmv"
2025-11-11T14:15:51.695345Z :YQ_RATE_LIMITER DEBUG: schema.cpp:122: Reply for create rate limiter resource "mock_cloud/my_folder/ptqudslmrhta5v3oppmv": 
2025-11-11T14:15:51.695375Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:180: Got create response from rate limiter service
2025-11-11T14:15:51.695395Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:102: PrivateCreateRateLimiterResource - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95, Got CP::CreateRateLimiterResourceResponse
2025-11-11T14:15:51.695682Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1477: QueryId: ptqudslmrhta5v3oppmv Rate limiter resource creation finished. Success: 1
2025-11-11T14:15:51.695697Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1966: QueryId: ptqudslmrhta5v3oppmv Compiling query ...
2025-11-11T14:15:51.695729Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95 Forward ping request: { status: RUNNING resources { rate_limiter: READY compilation: PREPARE rate_limiter_path: "local/RateLimiter_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/rate_limiter" } }
2025-11-11T14:15:51.696161Z :YQL_PROXY TRACE: log.cpp:64: SessionId: ptqudslmrhta5v3oppmv 2025-11-11 14:15:51.696 TRACE ydbd(pid=927307, tid=0x00007F7778D3F640) [perf] yql_facade.cpp:899: Execution of [ParseSql] took 292us
2025-11-11T14:15:51.696220Z :FQ_RUN_ACTOR WARN: run_actor.cpp:1914: QueryId: ptqudslmrhta5v3oppmv ResignQuery, status ABORTED
2025-11-11T14:15:51.696238Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95 Forward ping request: {  }
2025-11-11T14:15:51.696240Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1919: QueryId: ptqudslmrhta5v3oppmv SendPingAndPassAway, FinalQueryStatus COMPUTE_STATUS_UNSPECIFIED
2025-11-11T14:15:51.696261Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:536: QueryId: ptqudslmrhta5v3oppmv PassAway
2025-11-11T14:15:51.696328Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95 Forward ping request: { owner_id: "7645876b-61afea9c-2673eaf9-2d459ee95" query_id { value: "ptqudslmrhta5v3oppmv" } result_id { } status: RUNNING resign_query: true transient_issues { message: "Failed to parse query" severity: 1 issues { message: "Parse Sql" severity: 1 issues { position { row: 1 } message: "mismatched input \'blablabla\' expecting {\';\', \'(\', \'$\', ALTER, ANALYZE, BACKUP, BATCH, COMMIT, CREATE, DECLARE, DEFINE, DELETE, DISCARD, DO, DROP, EVALUATE, EXPLAIN, EXPORT, FOR, FROM, GRANT, IF, IMPORT, INSERT, PARALLEL, PRAGMA, PROCESS, REDUCE, REPLACE, RESTORE, REVOKE, ROLLBACK, SELECT, SHOW, UPDATE, UPSERT, USE, VALUES}" end_position { row: 1 } severity: 1 } } } status_code: ABORTED resources { rate_limiter: READY compilation: PREPARE rate_limiter_path: "local/RateLimiter_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/rate_limiter" } scope: "yandexcloud://my_folder" }
2025-11-11T14:15:51.698840Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1762870571 nanos: 694000000 } } SUCCESS
2025-11-11T14:15:51.698860Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95, Got CP::PingTaskResponse
2025-11-11T14:15:51.699173Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95 Ping response success: { expired_at { seconds: 1762870571 nanos: 694000000 } }
2025-11-11T14:15:51.699186Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95 Forward request Private::PingTask
2025-11-11T14:15:51.699575Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95, Request CP::PingTask with size: 123 bytes
2025-11-11T14:15:51.699650Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "7645876b-61afea9c-2673eaf9-2d459ee95"
query_id {
  value: "ptqudslmrhta5v3oppmv"
}
status: RUNNING
resources {
  rate_limiter: PREPARE
  compilation: PREPARE
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1762956951
  nanos: 684642000
}
tenant: "/default"
}
2025-11-11T14:15:51.711743Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1762870571 nanos: 705000000 } } SUCCESS
2025-11-11T14:15:51.711810Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95, Got CP::PingTaskResponse
2025-11-11T14:15:51.712125Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95 Ping response success: { expired_at { seconds: 1762870571 nanos: 705000000 } }
2025-11-11T14:15:51.712141Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95 Forward request Private::PingTask
2025-11-11T14:15:51.712515Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95, Request CP::PingTask with size: 192 bytes
2025-11-11T14:15:51.712622Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "7645876b-61afea9c-2673eaf9-2d459ee95"
query_id {
  value: "ptqudslmrhta5v3oppmv"
}
status: RUNNING
resources {
  rate_limiter: READY
  compilation: PREPARE
  rate_limiter_path: "local/RateLimiter_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/rate_limiter"
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1762956951
  nanos: 684642000
}
tenant: "/default"
}
2025-11-11T14:15:51.720430Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1762870571 nanos: 716000000 } } SUCCESS
2025-11-11T14:15:51.720457Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95, Got CP::PingTaskResponse
2025-11-11T14:15:51.720732Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95 Ping response success: { expired_at { seconds: 1762870571 nanos: 716000000 } }
2025-11-11T14:15:51.720747Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95 Forward request Private::PingTask
2025-11-11T14:15:51.721176Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95, Request CP::PingTask with size: 114 bytes
2025-11-11T14:15:51.721252Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "7645876b-61afea9c-2673eaf9-2d459ee95"
query_id {
  value: "ptqudslmrhta5v3oppmv"
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1762956951
  nanos: 684642000
}
tenant: "/default"
}
2025-11-11T14:15:51.782814Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1762870571 nanos: 753000000 } } SUCCESS
2025-11-11T14:15:51.782860Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95, Got CP::PingTaskResponse
2025-11-11T14:15:51.783178Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95 Ping response success: { expired_at { seconds: 1762870571 nanos: 753000000 } }
2025-11-11T14:15:51.783191Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95 Forward request Private::PingTask
2025-11-11T14:15:51.783646Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95, Request CP::PingTask with size: 584 bytes
2025-11-11T14:15:51.783762Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "7645876b-61afea9c-2673eaf9-2d459ee95"
query_id {
  value: "ptqudslmrhta5v3oppmv"
}
result_id {
}
status: RUNNING
resign_query: true
transient_issues {
  message: "Failed to parse query"
  severity: 1
  issues {
    message: "Parse Sql"
    severity: 1
    issues {
      position {
        row: 1
      }
      message: "mismatched input \'blablabla\' expecting {\';\', \'(\', \'$\', ALTER, ANALYZE, BACKUP, BATCH, COMMIT, CREATE, DECLARE, DEFINE, DELETE, DISCARD, DO, DROP, EVALUATE, EXPLAIN, EXPORT, FOR, FROM, GRANT, IF, IMPORT, INSERT, PARALLEL, PRAGMA, PROCESS, REDUCE, REPLACE, RESTORE, REVOKE, ROLLBACK, SELECT, SHOW, UPDATE, UPSERT, USE, VALUES}"
      end_position {
        row: 1
      }
      severity: 1
    }
  }
}
status_code: ABORTED
resources {
  rate_limiter: READY
  compilation: PREPARE
  rate_limiter_path: "local/RateLimiter_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/rate_limiter"
}
scope: "yandexcloud://my_folder"
deadline {
  seconds: 1762956951
  nanos: 684642000
}
tenant: "/default"
}
2025-11-11T14:15:51.787603Z :YQ_CONTROL_PLANE_STORAGE DEBUG: task_ping.cpp:427: PingTaskRequest (resign):  FAILURE ABORTED 0 2025-11-11T14:15:50.696244Z 0.000000s
2025-11-11T14:15:51.821223Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
2025-11-11T14:15:51.821269Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:313: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7571471365432978270:2291]
2025-11-11T14:15:51.821293Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:375: Cloud id: mock_cloud Folder id: my_folder
2025-11-11T14:15:51.821330Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
2025-11-11T14:15:51.821388Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:176: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7571471365432978271:2292]
2025-11-11T14:15:51.821425Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:237: Subject Type: federated_account Token: **** (B6C6F477)
2025-11-11T14:15:51.821457Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
2025-11-11T14:15:51.821486Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:69: Request actor. Actor id: [1:7571471365432978272:2293]
2025-11-11T14:15:51.821532Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudslmrhta5v3oppmv"
} [root@builtin, **** (B6C6F477)] 
2025-11-11T14:15:51.823856Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudslmrhta5v3oppmv" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1762870549 nanos: 370576000 } modified_at { seconds: 1762870550 nanos: 696149000 } revision: 2 } started_at { seconds: 1762870551 nanos: 689000000 } execute_mode: RUN status: RUNNING last_job_query_revision: 2 last_job_id: "ptjudslmrgkrool3bqrv-ptqudslmrhta5v3oppmv" started_by: "root@builtin" submitted_at { seconds: 1762870550 nanos: 696149000 } } content { type: STREAMING name: "q" acl { visibility: PRIVATE } text: "blablabla" } } } SUCCESS
2025-11-11T14:15:51.856841Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {expired_at { seconds: 1762870551 nanos: 787000000 } } SUCCESS
2025-11-11T14:15:51.856889Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95, Got CP::PingTaskResponse
2025-11-11T14:15:51.857255Z :FQ_PINGER ERROR: pinger.cpp:365: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95 Ping response error: Query ownership time is over: expired_at=2025-11-11T14:15:51.787000Z < now=2025-11-11T14:15:51.856337Z. Retried 0 times during 0.073730s
2025-11-11T14:15:51.857276Z :FQ_PINGER DEBUG: pinger.cpp:379: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95 Query finished
2025-11-11T14:15:51.857278Z :FQ_PINGER TRACE: pinger.cpp:187: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee95 Stop Pinger
2025-11-11T14:15:52.326297Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
2025-11-11T14:15:52.326354Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:313: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7571471369727945572:2296]
2025-11-11T14:15:52.326376Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:375: Cloud id: mock_cloud Folder id: my_folder
2025-11-11T14:15:52.326389Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
2025-11-11T14:15:52.326427Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:176: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7571471369727945573:2297]
2025-11-11T14:15:52.326455Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:237: Subject Type: federated_account Token: **** (B6C6F477)
2025-11-11T14:15:52.326490Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
2025-11-11T14:15:52.326532Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:69: Request actor. Actor id: [1:7571471369727945574:2298]
2025-11-11T14:15:52.326580Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudslmrhta5v3oppmv"
} [root@builtin, **** (B6C6F477)] 
2025-11-11T14:15:52.329180Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudslmrhta5v3oppmv" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1762870549 nanos: 370576000 } modified_at { seconds: 1762870550 nanos: 696149000 } revision: 2 } started_at { seconds: 1762870551 nanos: 689000000 } execute_mode: RUN status: FAILING last_job_query_revision: 2 last_job_id: "ptjudslmrgkrool3bqrv-ptqudslmrhta5v3oppmv" started_by: "root@builtin" submitted_at { seconds: 1762870550 nanos: 696149000 } } content { type: STREAMING name: "q" acl { visibility: PRIVATE } text: "blablabla" } issue { message: "Query failed with code ABORTED at 2025-11-11T14:15:51.787559Z" severity: 1 issues { message: "Failed to parse query" severity: 1 issues { message: "Parse Sql" severity: 1 issues { position { row: 1 } message: "mismatched input \'blablabla\' expecting {\';\', \'(\', \'$\', ALTER, ANALYZE, BACKUP, BATCH, COMMIT, CREATE, DECLARE, DEFINE, DELETE, DISCARD, DO, DROP, EVALUATE, EXPLAIN, EXPORT, FOR, FROM, GRANT, IF, IMPORT, INSERT, PARALLEL, PRAGMA, PROCESS, REDUCE, REPLACE, RESTORE, REVOKE, ROLLBACK, SELECT, SHOW, UPDATE, UPSERT, USE, VALUES}" end_position { row: 1 } severity: 1 } } } } } } SUCCESS
2025-11-11T14:15:52.665344Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:617: RowDispatcher: Send ping to [1:7571471352548076173:2110]
2025-11-11T14:15:52.665372Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1161: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-11-11T14:15:52.665380Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:314: Coordinator: TEvPing received, [1:7571471352548076127:2069]
2025-11-11T14:15:52.665383Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:317: Coordinator: Send TEvPong to [1:7571471352548076127:2069]
2025-11-11T14:15:52.665394Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:623: RowDispatcher: NActors::TEvents::TEvPong
2025-11-11T14:15:52.679682Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:542: Coordinator: Send TEvGetNodesRequest to NodesManager
2025-11-11T14:15:52.679693Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 7645876b-61afea9c-2673eaf9-2d459ee97, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:15:52.679700Z :YQL_NODES_MANAGER DEBUG: nodes_manager.cpp:300: TNodesManagerActor::TEvGetNodesRequest
2025-11-11T14:15:52.679713Z :FQ_ROW_DISPATCHER INFO: coordinator.cpp:573: Coordinator: Updated node info, node count: 0
2025-11-11T14:15:52.680139Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 7645876b-61afea9c-2673eaf9-2d459ee97, Host: ghrun-vb3yoermsa, Tenant: /default, Request CP::GetTask with size: 68 bytes
2025-11-11T14:15:52.680197Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "7645876b-61afea9c-2673eaf9-2d459ee97"
host: "ghrun-vb3yoermsa"
node_id: 1
}
2025-11-11T14:15:52.682903Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:456: Task (Query): ptqudslmrhta5v3oppmv Lease TIMEOUT, RetryCounterUpdatedAt 2025-11-11T14:15:50.696244Z LastSeenAt: 2025-11-11T14:15:51.787673Z
2025-11-11T14:15:52.682916Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:463: Task (Query): ptqudslmrhta5v3oppmv RetryRate: 1.999747354 RetryCounter: 1 At: 2025-11-11T14:15:52.682868Z
2025-11-11T14:15:52.691923Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {tasks { query_id { value: "ptqudslmrhta5v3oppmv" } job_id { value: "ptjudslmrgkrool3bqrv" } generation: 3 streaming: true dq_graph: "\022\320\002\010\001\022\024\n\022\t\000\000\000\000\000\000\000\000\021\000\000\000\000\000\000\000\000\032\004\010\240\215\00628\n4\010\001\030\002 \001*\024\n\022\t\000\000\000\000\000\000\000\000\021\000\000\000\000\000\000\000\0002\024\n\022\t\001\000\000\000\000\000\000\000\021\000\000\000\000\001\000\000\000X\001R\000:s\n*type.googleapis.com/Yql.DqsProto.TTaskMeta\022E\010\001\022A\022(8d73c3b672aec01e659c446142c7a17d47fb7b86\032\023dq_vanilla_job.lite \002H\001RClocal/RateLimiter_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/rate_limiterZ)mock_cloud/my_folder/ptqudslmrhta5v3oppmv`\200\200\200\200 \312\001\010/default\"\017\037\000\205\002\203\002\034column0/*\007column02qptqudslmrhta5v3oppmv#ptrudslmrheq7v6kdmu0#yandexcloud://my_folder#7645876b-61afea9c-2673eaf9-2d459ee92#mock_cloud:\024\n\017_LiteralTimeout\022\0010:\022\n\r_TableTimeout\022\0010:\037\n\025_AllResultsBytesLimit\022\006100000:\032\n\022_RowsLimitPerWrite\022\0041000:\027\n\022EnableComputeActor\022\0011:\016\n\014WorkerFilter:\031\n\020ComputeActorType\022\005async:\031\n\016WatermarksMode\022\007disable:\037\n\027WatermarksGranularityMs\022\0041000:$\n\034WatermarksLateArrivalDelayMs\022\0045000:\027\n\022EnableChannelStats\022\0011:\020\n\013ExportStats\022\0011be\010\001\022a\037\000\005\205\006\213\000\205\000\204\205\002\203\002\034column0\030Inputs(Parameters\034Program\013\213\000)\251\000?\002\014Arg\000\004)\211\002?\010\206?\006 Iterator\000\006\002?\024\005?\006\003?\004\250\001\001\001\002\001/" text: "blablabla" user_token: "root@builtin" user_id: "root@builtin" query_type: STREAMING scope: "yandexcloud://my_folder" execute_mode: RUN state_load_mode: EMPTY status: FAILING sensor_labels { key: "cloud_id" value: "mock_cloud" } sensor_labels { key: "scope" value: "yandexcloud://my_folder" } query_name: "q" deadline { seconds: 1762956952 nanos: 686882000 } disposition { fresh { } } result_limit: 20971520 execution_limit { } request_started_at { seconds: 1762870551 nanos: 689000000 } restart_count: 1 resources { rate_limiter: READY compilation: PREPARE rate_limiter_path: "local/RateLimiter_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/rate_limiter" } compute_connection { } result_ttl { seconds: 86400 } request_submitted_at { seconds: 1762870550 nanos: 696149000 } } } SUCCESS
2025-11-11T14:15:52.691974Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 7645876b-61afea9c-2673eaf9-2d459ee97, Host: ghrun-vb3yoermsa, Tenant: /default, Got CP::GetTask Response
2025-11-11T14:15:52.692334Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:15:52.692345Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 1
2025-11-11T14:15:52.692356Z :FQ_PENDING_FETCHER DEBUG: pending_fetcher.cpp:361: NewTask: Scope: yandexcloud://my_folder Id: ptqudslmrhta5v3oppmv UserId: root@builtin AuthToken: **** (B6C6F477)
2025-11-11T14:15:52.692473Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:375: QueryId: ptqudslmrhta5v3oppmv Start run actor. Compute state: FAILING
2025-11-11T14:15:52.692476Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 7645876b-61afea9c-2673eaf9-2d459ee98, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:15:52.692482Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:469: QueryId: ptqudslmrhta5v3oppmv FillConnections
2025-11-11T14:15:52.692507Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:2333: QueryId: ptqudslmrhta5v3oppmv Run actors params: { QueryId: ptqudslmrhta5v3oppmv CloudId: mock_cloud UserId: root@builtin Owner: 7645876b-61afea9c-2673eaf9-2d459ee97 PreviousQueryRevision: 3 Connections: 0 Bindings: 0 AccountIdSignatures: 0 QueryType: STREAMING ExecuteMode: RUN ResultId: ptrudslmrenuannkehik StateLoadMode: EMPTY StreamingDisposition: { fresh { } } Status: FAILING DqGraphs: 1 DqGraphIndex: 0 Resource.TopicConsumers: 0 }
2025-11-11T14:15:52.692527Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1827: QueryId: ptqudslmrhta5v3oppmv Is about to finish query with status FAILED
2025-11-11T14:15:52.692530Z :FQ_PINGER TRACE: pinger.cpp:171: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee97 Start Pinger
2025-11-11T14:15:52.692533Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1508: QueryId: ptqudslmrhta5v3oppmv Start rate limiter resource deleter
2025-11-11T14:15:52.692889Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:86: PrivateGetTask - Owner: 7645876b-61afea9c-2673eaf9-2d459ee98, Host: ghrun-vb3yoermsa, Tenant: /default, Request CP::GetTask with size: 68 bytes
2025-11-11T14:15:52.692912Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:175: PrivateDeleteRateLimiterResource - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee97, Request CP::DeleteRateLimiterResource with size: 97 bytes
2025-11-11T14:15:52.692935Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_get.cpp:388: GetTaskRequest: {tenant: "/default"
owner_id: "7645876b-61afea9c-2673eaf9-2d459ee98"
host: "ghrun-vb3yoermsa"
node_id: 1
}
2025-11-11T14:15:52.693017Z :YQ_CONTROL_PLANE_STORAGE TRACE: request_actor.h:57: DeleteRateLimiterResourceRequest: {owner_id: "7645876b-61afea9c-2673eaf9-2d459ee97"
query_id {
  value: "ptqudslmrhta5v3oppmv"
}
scope: "yandexcloud://my_folder"
tenant: "/default"
} 
2025-11-11T14:15:52.695201Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:74: DeleteRateLimiterResourceRequest. Got response from database: SUCCESS
2025-11-11T14:15:52.695213Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: GetTaskRequest - GetTaskResult: {} SUCCESS
2025-11-11T14:15:52.695233Z :YQL_PRIVATE_PROXY DEBUG: task_get.cpp:93: PrivateGetTask - Owner: 7645876b-61afea9c-2673eaf9-2d459ee98, Host: ghrun-vb3yoermsa, Tenant: /default, Got CP::GetTask Response
2025-11-11T14:15:52.695265Z :YQ_RATE_LIMITER DEBUG: schema.cpp:71: Run delete rate limiter resource "mock_cloud/my_folder/ptqudslmrhta5v3oppmv" actor
2025-11-11T14:15:52.695271Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call delete rate limiter resource "mock_cloud/my_folder/ptqudslmrhta5v3oppmv"
2025-11-11T14:15:52.695480Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:15:52.695489Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-11-11T14:15:52.696789Z :YQ_RATE_LIMITER DEBUG: schema.cpp:179: Successfully deleted rate limiter resource "mock_cloud/my_folder/ptqudslmrhta5v3oppmv"
2025-11-11T14:15:52.696799Z :YQ_RATE_LIMITER DEBUG: schema.cpp:122: Reply for delete rate limiter resource "mock_cloud/my_folder/ptqudslmrhta5v3oppmv": 
2025-11-11T14:15:52.696837Z :YQ_CONTROL_PLANE_STORAGE DEBUG: rate_limiter_resources.cpp:219: Got delete response from rate limiter service
2025-11-11T14:15:52.696862Z :YQL_PRIVATE_PROXY DEBUG: rate_limiter_resources.cpp:199: PrivateDeleteRateLimiterResource - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee97, Got CP::DeleteRateLimiterResourceResponse
2025-11-11T14:15:52.697167Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1499: QueryId: ptqudslmrhta5v3oppmv Rate limiter resource deletion finished. Success: 1. Issues: 
2025-11-11T14:15:52.697186Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:1919: QueryId: ptqudslmrhta5v3oppmv SendPingAndPassAway, FinalQueryStatus FAILED
2025-11-11T14:15:52.697199Z :FQ_RUN_ACTOR DEBUG: run_actor.cpp:536: QueryId: ptqudslmrhta5v3oppmv PassAway
2025-11-11T14:15:52.697247Z :FQ_PINGER TRACE: pinger.cpp:250: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee97 Forward ping request: { result_id { } status: FAILED resources { rate_limiter: READY compilation: PREPARE rate_limiter_path: "local/RateLimiter_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/rate_limiter" } finished_at { seconds: 1762870552 nanos: 692000000 } }
2025-11-11T14:15:52.697260Z :FQ_PINGER TRACE: pinger.cpp:393: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee97 Forward request Private::PingTask
2025-11-11T14:15:52.697653Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:85: PrivatePingTask - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee97, Request CP::PingTask with size: 209 bytes
2025-11-11T14:15:52.697723Z :YQ_CONTROL_PLANE_STORAGE TRACE: task_ping.cpp:651: PingTaskRequest: {owner_id: "7645876b-61afea9c-2673eaf9-2d459ee97"
query_id {
  value: "ptqudslmrhta5v3oppmv"
}
result_id {
}
status: FAILED
resources {
  rate_limiter: READY
  compilation: PREPARE
  rate_limiter_path: "local/RateLimiter_f5b6631e-434f-418b-bbbc-2b42f29bdcb4/rate_limiter"
}
scope: "yandexcloud://my_folder"
finished_at {
  seconds: 1762870552
  nanos: 692000000
}
deadline {
  seconds: 1762956952
  nanos: 686882000
}
tenant: "/default"
}
2025-11-11T14:15:52.701859Z :YQ_CONTROL_PLANE_STORAGE NOTICE: task_ping.cpp:224: Query ptqudslmrhta5v3oppmv is NOT billable, status: FAILED, statusCode: ABORTED
2025-11-11T14:15:52.766104Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: PingTaskRequest - PingTaskResult: {} SUCCESS
2025-11-11T14:15:52.766138Z :YQL_PRIVATE_PROXY DEBUG: task_ping.cpp:105: PrivatePingTask - QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee97, Got CP::PingTaskResponse
2025-11-11T14:15:52.766440Z :FQ_PINGER TRACE: pinger.cpp:338: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee97 Ping response success: {  }
2025-11-11T14:15:52.766452Z :FQ_PINGER DEBUG: pinger.cpp:379: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee97 Query finished
2025-11-11T14:15:52.766454Z :FQ_PINGER TRACE: pinger.cpp:187: QueryId: ptqudslmrhta5v3oppmv, Owner: 7645876b-61afea9c-2673eaf9-2d459ee97 Stop Pinger
2025-11-11T14:15:52.831774Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
2025-11-11T14:15:52.831826Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:313: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7571471369727945596:2319]
2025-11-11T14:15:52.831859Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:375: Cloud id: mock_cloud Folder id: my_folder
2025-11-11T14:15:52.831901Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
2025-11-11T14:15:52.831964Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:176: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7571471369727945597:2320]
2025-11-11T14:15:52.832007Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:237: Subject Type: federated_account Token: **** (B6C6F477)
2025-11-11T14:15:52.832037Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
2025-11-11T14:15:52.832065Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:69: Request actor. Actor id: [1:7571471369727945598:2321]
2025-11-11T14:15:52.832126Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudslmrhta5v3oppmv"
} [root@builtin, **** (B6C6F477)] 
2025-11-11T14:15:52.834615Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudslmrhta5v3oppmv" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1762870549 nanos: 370576000 } modified_at { seconds: 1762870550 nanos: 696149000 } revision: 2 } started_at { seconds: 1762870551 nanos: 689000000 } finished_at { seconds: 1762870552 nanos: 692000000 } execute_mode: RUN status: FAILED last_job_query_revision: 2 last_job_id: "ptjudslmrgkrool3bqrv-ptqudslmrhta5v3oppmv" started_by: "root@builtin" submitted_at { seconds: 1762870550 nanos: 696149000 } } content { type: STREAMING name: "q" acl { visibility: PRIVATE } text: "blablabla" } issue { message: "Query failed with code ABORTED at 2025-11-11T14:15:51.787559Z" severity: 1 issues { message: "Failed to parse query" severity: 1 issues { message: "Parse Sql" severity: 1 issues { position { row: 1 } message: "mismatched input \'blablabla\' expecting {\';\', \'(\', \'$\', ALTER, ANALYZE, BACKUP, BATCH, COMMIT, CREATE, DECLARE, DEFINE, DELETE, DISCARD, DO, DROP, EVALUATE, EXPLAIN, EXPORT, FOR, FROM, GRANT, IF, IMPORT, INSERT, PARALLEL, PRAGMA, PROCESS, REDUCE, REPLACE, RESTORE, REVOKE, ROLLBACK, SELECT, SHOW, UPDATE, UPSERT, USE, VALUES}" end_position { row: 1 } severity: 1 } } } } } } SUCCESS
2025-11-11T14:15:52.836487Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
2025-11-11T14:15:52.836513Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:313: Resolve folder bootstrap. Folder id: my_folder Actor id: [1:7571471369727945602:2324]
2025-11-11T14:15:52.836534Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:375: Cloud id: mock_cloud Folder id: my_folder
2025-11-11T14:15:52.836555Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
2025-11-11T14:15:52.836580Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:176: Resolve subject type bootstrap. Token: **** (B6C6F477) Actor id: [1:7571471369727945603:2325]
2025-11-11T14:15:52.836609Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:237: Subject Type: federated_account Token: **** (B6C6F477)
2025-11-11T14:15:52.836639Z :YQ_CONTROL_PLANE_PROXY TRACE: control_plane_proxy.cpp:790: DescribeQueryRequest: query_id: "ptqudslmrhta5v3oppmv"
2025-11-11T14:15:52.836675Z :YQ_CONTROL_PLANE_PROXY TRACE: request_actor.h:69: Request actor. Actor id: [1:7571471369727945604:2326]
2025-11-11T14:15:52.836723Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_queries.cpp:641: DescribeQueryRequest: {query_id: "ptqudslmrhta5v3oppmv"
} [root@builtin, **** (B6C6F477)] 
2025-11-11T14:15:52.838752Z :YQ_CONTROL_PLANE_STORAGE TRACE: ydb_control_plane_storage_impl.h:788: DescribeQueryRequest - DescribeQueryResult: {query { meta { common { id: "ptqudslmrhta5v3oppmv" created_by: "root@builtin" modified_by: "root@builtin" created_at { seconds: 1762870549 nanos: 370576000 } modified_at { seconds: 1762870550 nanos: 696149000 } revision: 2 } started_at { seconds: 1762870551 nanos: 689000000 } finished_at { seconds: 1762870552 nanos: 692000000 } execute_mode: RUN status: FAILED last_job_query_revision: 2 last_job_id: "ptjudslmrgkrool3bqrv-ptqudslmrhta5v3oppmv" started_by: "root@builtin" submitted_at { seconds: 1762870550 nanos: 696149000 } } content { type: STREAMING name: "q" acl { visibility: PRIVATE } text: "blablabla" } issue { message: "Query failed with code ABORTED at 2025-11-11T14:15:51.787559Z" severity: 1 issues { message: "Failed to parse query" severity: 1 issues { message: "Parse Sql" severity: 1 issues { position { row: 1 } message: "mismatched input \'blablabla\' expecting {\';\', \'(\', \'$\', ALTER, ANALYZE, BACKUP, BATCH, COMMIT, CREATE, DECLARE, DEFINE, DELETE, DISCARD, DO, DROP, EVALUATE, EXPLAIN, EXPORT, FOR, FROM, GRANT, IF, IMPORT, INSERT, PARALLEL, PRAGMA, PROCESS, REDUCE, REPLACE, RESTORE, REVOKE, ROLLBACK, SELECT, SHOW, UPDATE, UPSERT, USE, VALUES}" end_position { row: 1 } severity: 1 } } } } } } SUCCESS
2025-11-11T14:15:53.678092Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:318: TNodesManagerActor::NodesHealthCheck
2025-11-11T14:15:53.680132Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 7645876b-61afea9c-2673eaf9-2d459ee99, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:15:53.680139Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:542: Coordinator: Send TEvGetNodesRequest to NodesManager
2025-11-11T14:15:53.680148Z :YQL_NODES_MANAGER DEBUG: nodes_manager.cpp:300: TNodesManagerActor::TEvGetNodesRequest
2025-11-11T14:15:53.680154Z :FQ_ROW_DISPATCHER INFO: coordinator.cpp:573: Coordinator: Updated node info, node count: 0
2025-11-11T14:15:53.682797Z :YQL_NODES_MANAGER ERROR: nodes_manager.cpp:395: ydb/core/fq/libs/actors/nodes_manager.cpp:353: TRANSPORT_UNAVAILABLE
<main>: Error: GRpc error: (14): connections to all backends failing; last error: UNKNOWN: ipv4:127.0.1.1:65509: Failed to connect to remote host: Connection refused
<main>: Error: Grpc error response on endpoint ghrun-vb3yoermsa.auto.internal:65509
2025-11-11T14:15:53.682814Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:15:53.682819Z :FQ_PENDING_FETCHER ERROR: pending_fetcher.cpp:259: Error with GetTask: <main>: Error: GRpc error: (14): connections to all backends failing; last error: UNKNOWN: ipv4:127.0.1.1:65509: Failed to connect to remote host: Connection refused
<main>: Error: Grpc error response on endpoint ghrun-vb3yoermsa.auto.internal:65509
2025-11-11T14:15:54.666256Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:617: RowDispatcher: Send ping to [1:7571471352548076173:2110]
2025-11-11T14:15:54.666272Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1161: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-11-11T14:15:54.666279Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:314: Coordinator: TEvPing received, [1:7571471352548076127:2069]
2025-11-11T14:15:54.666283Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:317: Coordinator: Send TEvPong to [1:7571471352548076127:2069]
2025-11-11T14:15:54.666295Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:623: RowDispatcher: NActors::TEvents::TEvPong
2025-11-11T14:15:54.680578Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:542: Coordinator: Send TEvGetNodesRequest to NodesManager
2025-11-11T14:15:54.680578Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: 7645876b-61afea9c-2673eaf9-2d459ee910, Host: ghrun-vb3yoermsa, Tenant: /default
2025-11-11T14:15:54.680605Z :YQL_NODES_MANAGER DEBUG: nodes_manager.cpp:300: TNodesManagerActor::TEvGetNodesRequest
2025-11-11T14:15:54.680611Z :FQ_ROW_DISPATCHER INFO: coordinator.cpp:573: Coordinator: Updated node info, node count: 0
2025-11-11T14:15:54.685659Z :FQ_CONTROL_PLANE_CONFIG TRACE: control_plane_config.cpp:192: LOADED TenantInfo: State NOT changed
2025-11-11T14:15:54.685701Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-11-11T14:15:54.685710Z :FQ_PENDING_FETCHER ERROR: pending_fetcher.cpp:259: Error with GetTask: <main>: Error: GRpc error: (14): connections to all backends failing; last error: UNKNOWN: ipv4:127.0.1.1:65509: Failed to connect to remote host: Connection refused
<main>: Error: Grpc error response on endpoint ghrun-vb3yoermsa.auto.internal:65509
