2025-10-16T17:43:51.271904Z :YQL_NODES_MANAGER INFO: nodes_manager.cpp:88: Bootstrap, InstanceId: 3a3c447b-4b10ea2b-58052eb7-57776d58
2025-10-16T17:43:51.271930Z :YQL_NODES_MANAGER DEBUG: nodes_manager.cpp:310: TNodesManagerActor::ResolveSelfAddress
2025-10-16T17:43:51.272870Z :YQ_TEST_CONNECTION DEBUG: test_connection.cpp:142: Starting yandex query test connection. Actor id: [3:7561876751696558477:2072]
2025-10-16T17:43:51.273642Z :GRPC_SERVER NOTICE: grpc_request_proxy_simple.cpp:161: Grpc simple request proxy started, nodeid# 3
2025-10-16T17:43:51.274085Z :GRPC_SERVER NOTICE: grpc_request_proxy_simple.cpp:161: Grpc simple request proxy started, nodeid# 3
2025-10-16T17:43:51.274188Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: a8048d02-e55df7c7-7f02b4e6-b2ab40841, Host: ghrun-2kszfvc6cm, Tenant: /default
2025-10-16T17:43:51.274394Z :FQ_LOG_UPDATER DEBUG: log.cpp:93: Updated YQL logs priority: 8
2025-10-16T17:43:51.274483Z :FQ_LOG_UPDATER CRIT: log.cpp:55: Failed to deliver subscription request to config dispatcher.
2025-10-16T17:43:51.274634Z :YQ_CONTROL_PLANE_STORAGE INFO: ydb_control_plane_storage.cpp:50: Starting ydb control plane storage service. Actor id: [3:7561876751696558465:2060]
2025-10-16T17:43:51.276564Z :FQ_QUOTA_PROXY INFO: quota_proxy.cpp:90: STARTED
2025-10-16T17:43:51.276824Z :FQ_CONTROL_PLANE_CONFIG DEBUG: control_plane_config.cpp:58: STARTING: [3:7561876751696558466:2061]
2025-10-16T17:43:51.277489Z :MEMORY_PROFILER NOTICE: monitor.cpp:332: Bootstrapped
2025-10-16T17:43:51.277803Z :YQ_CONTROL_PLANE_PROXY DEBUG: control_plane_proxy.cpp:525: Starting yandex query control plane proxy. Actor id: [3:7561876751696558467:2062]
2025-10-16T17:43:51.279864Z :YQ_RATE_LIMITER INFO: quoter_service.cpp:124: Bootstraping with config: { Enabled: true ControlPlaneEnabled: true DataPlaneEnabled: true Database { Endpoint: "localhost:27709" Database: "local" TablePrefix: "RateLimiter_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1" } Limiters { CoordinationNodePath: "rate_limiter" } }
2025-10-16T17:43:51.287578Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/tenants" actor
2025-10-16T17:43:51.288183Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/tenant_acks" actor
2025-10-16T17:43:51.288405Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/compute_databases" actor
2025-10-16T17:43:51.289230Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create directory "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1" actor
2025-10-16T17:43:51.289274Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create directory "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1"
2025-10-16T17:43:51.289295Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:383: Call create directory "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1"
2025-10-16T17:43:51.289791Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:158: Bootstrap
2025-10-16T17:43:51.290272Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:178: Initialize
2025-10-16T17:43:51.304935Z :FQ_QUOTA_SERVICE INFO: quota_manager.cpp:196: STARTED
2025-10-16T17:43:51.304991Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/mappings" actor
2025-10-16T17:43:51.305090Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/queries" actor
2025-10-16T17:43:51.305155Z :YQ_RATE_LIMITER DEBUG: schema.cpp:71: Run create coordination node "local/RateLimiter_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/rate_limiter" actor
2025-10-16T17:43:51.305166Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create coordination node "local/RateLimiter_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/rate_limiter"
2025-10-16T17:43:51.305175Z :YQ_RATE_LIMITER DEBUG: schema.cpp:411: Call create coordination node "local/RateLimiter_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/rate_limiter"
2025-10-16T17:43:51.305222Z :FQ_ROW_DISPATCHER DEBUG: row_dispatcher.cpp:537: RowDispatcher: Successfully bootstrapped row dispatcher, id [3:7561876751696558472:2067], tenant /default
2025-10-16T17:43:51.305304Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/pending_small" actor
2025-10-16T17:43:51.305552Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/connections" actor
2025-10-16T17:43:51.305772Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/bindings" actor
2025-10-16T17:43:51.306049Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/idempotency_keys" actor
2025-10-16T17:43:51.306284Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/result_sets" actor
2025-10-16T17:43:51.306387Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/jobs" actor
2025-10-16T17:43:51.306461Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/nodes" actor
2025-10-16T17:43:51.306626Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:267: Coordinator: Successfully bootstrapped coordinator, id [3:7561876751696558581:2144], NodesManagerId [0:4705493345362661702:78]
2025-10-16T17:43:51.306756Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:232: TLeaderElection [3:7561876751696558582:2145] Successfully bootstrapped, local coordinator id [3:7561876751696558581:2144], tenant id default, local mode 0, coordination node path local/row_dispatcher/default
2025-10-16T17:43:51.310592Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:318: TNodesManagerActor::NodesHealthCheck
2025-10-16T17:43:51.311824Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/quotas" actor
2025-10-16T17:43:51.312241Z :FQ_ROW_DISPATCHER DEBUG: row_dispatcher.cpp:630: RowDispatcher: TEvCoordinatorChangesSubscribe from [3:7561876751696558581:2144]
2025-10-16T17:43:51.313459Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:71: Run create coordination node "local/row_dispatcher/default" actor
2025-10-16T17:43:51.313481Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:113: Call create coordination node "local/row_dispatcher/default"
2025-10-16T17:43:51.313493Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:411: Call create coordination node "local/row_dispatcher/default"
2025-10-16T17:43:51.335194Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:155: Successfully created coordination node "local/row_dispatcher/default"
2025-10-16T17:43:51.335338Z :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: 13], type: EPathTypeKesus, state: EPathStateNoChanges) }
2025-10-16T17:43:51.335434Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:345: TLeaderElection [3:7561876751696558582:2145] Coordination node successfully created
2025-10-16T17:43:51.335469Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:323: TLeaderElection [3:7561876751696558582:2145] Start session
2025-10-16T17:43:51.365773Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:359: TLeaderElection [3:7561876751696558582:2145] Session successfully created
2025-10-16T17:43:51.369573Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:372: TLeaderElection [3:7561876751696558582:2145] Semaphore successfully created
2025-10-16T17:43:51.369602Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:304: TLeaderElection [3:7561876751696558582:2145] Try to acquire semaphore
2025-10-16T17:43:51.369908Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:420: TLeaderElection [3:7561876751696558582:2145] Describe semaphore
2025-10-16T17:43:51.372677Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/tenants". Create session OK
2025-10-16T17:43:51.372743Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/tenants"
2025-10-16T17:43:51.372752Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/tenants"
2025-10-16T17:43:51.372869Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/tenant_acks". Create session OK
2025-10-16T17:43:51.372900Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/tenant_acks"
2025-10-16T17:43:51.372942Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/tenant_acks"
2025-10-16T17:43:51.376211Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/bindings". Create session OK
2025-10-16T17:43:51.376235Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/pending_small". Create session OK
2025-10-16T17:43:51.376257Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/pending_small"
2025-10-16T17:43:51.376268Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/pending_small"
2025-10-16T17:43:51.376272Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/bindings"
2025-10-16T17:43:51.376292Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/bindings"
2025-10-16T17:43:51.378471Z :YQ_RATE_LIMITER DEBUG: schema.cpp:155: Successfully created coordination node "local/RateLimiter_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/rate_limiter"
2025-10-16T17:43:51.378479Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/nodes". Create session OK
2025-10-16T17:43:51.378495Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/nodes"
2025-10-16T17:43:51.378501Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/nodes"
2025-10-16T17:43:51.378523Z :YQ_RATE_LIMITER DEBUG: schema.cpp:122: Reply for create coordination node "local/RateLimiter_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/rate_limiter": { <main>: Error: Check failed: path: '/local/RateLimiter_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/rate_limiter', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 77], type: EPathTypeKesus, state: EPathStateNoChanges) }
2025-10-16T17:43:51.378578Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/idempotency_keys". Create session OK
2025-10-16T17:43:51.378586Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/idempotency_keys"
2025-10-16T17:43:51.378596Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/idempotency_keys"
2025-10-16T17:43:51.380739Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/connections". Create session OK
2025-10-16T17:43:51.380798Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/connections"
2025-10-16T17:43:51.380806Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/connections"
2025-10-16T17:43:51.380881Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/quotas". Create session OK
2025-10-16T17:43:51.380899Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/quotas"
2025-10-16T17:43:51.380904Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/quotas"
2025-10-16T17:43:51.382967Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/compute_databases". Create session OK
2025-10-16T17:43:51.383004Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/compute_databases"
2025-10-16T17:43:51.383009Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/compute_databases"
2025-10-16T17:43:51.383190Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/jobs". Create session OK
2025-10-16T17:43:51.383229Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/jobs"
2025-10-16T17:43:51.383235Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/jobs"
2025-10-16T17:43:51.385644Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created directory "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1"
2025-10-16T17:43:51.385742Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create directory "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1": { <main>: Error: Check failed: path: '/local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 71], type: EPathTypeDir, state: EPathStateNoChanges) }
2025-10-16T17:43:51.385783Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/mappings". Create session OK
2025-10-16T17:43:51.385798Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/mappings"
2025-10-16T17:43:51.385803Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/mappings"
2025-10-16T17:43:51.385918Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/result_sets". Create session OK
2025-10-16T17:43:51.385931Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/result_sets"
2025-10-16T17:43:51.385937Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/result_sets"
2025-10-16T17:43:51.387928Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/queries". Create session OK
2025-10-16T17:43:51.387951Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/queries"
2025-10-16T17:43:51.387957Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/queries"
2025-10-16T17:43:51.388173Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:469: TLeaderElection [3:7561876751696558582:2145] Semaphore successfully described: coordinator id [1:7561876745496806031:2144] generation 4
2025-10-16T17:43:51.388244Z :FQ_ROW_DISPATCHER INFO: leader_election.cpp:471: TLeaderElection [3:7561876751696558582:2145] Send TEvCoordinatorChanged to [3:7561876751696558472:2067], new coordinator id [1:7561876745496806031:2144], previous coordinator id [0:0:0]
2025-10-16T17:43:51.388345Z :FQ_ROW_DISPATCHER DEBUG: row_dispatcher.cpp:562: RowDispatcher: Coordinator changed, old leader (empty maybe), new [1:7561876745496806031:2144] generation 4
2025-10-16T17:43:51.388507Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:386: Coordinator: New leader [1:7561876745496806031:2144], SelfId [3:7561876751696558581:2144]
2025-10-16T17:43:51.388674Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:600: RowDispatcher: TEvUndelivered, from [1:7561876745496806031:2144], reason Disconnected
2025-10-16T17:43:51.392213Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-10-16T17:43:51.392254Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-10-16T17:43:51.392348Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/tenants"
2025-10-16T17:43:51.392425Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/tenants": { <main>: Error: Check failed: path: '/local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/tenants', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 72], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-10-16T17:43:51.393226Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/tenant_acks"
2025-10-16T17:43:51.393334Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/tenant_acks": { <main>: Error: Check failed: path: '/local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/tenant_acks', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 78], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-10-16T17:43:51.395575Z :FQ_CONTROL_PLANE_CONFIG DEBUG: control_plane_config.cpp:190: LOADED TenantInfo: State CHANGED at 2025-10-16T17:43:46.397185Z
2025-10-16T17:43:51.401443Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/bindings"
2025-10-16T17:43:51.401513Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/bindings": { <main>: Error: Check failed: path: '/local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/bindings', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 86], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-10-16T17:43:51.401881Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/pending_small"
2025-10-16T17:43:51.401966Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/pending_small": { <main>: Error: Check failed: path: '/local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/pending_small', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 80], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-10-16T17:43:51.403902Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/idempotency_keys"
2025-10-16T17:43:51.403959Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/idempotency_keys": { <main>: Error: Check failed: path: '/local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/idempotency_keys', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 88], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-10-16T17:43:51.404420Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/nodes"
2025-10-16T17:43:51.404507Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/nodes": { <main>: Error: Check failed: path: '/local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/nodes', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 87], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-10-16T17:43:51.407264Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:389: Send NodeInfo with size: 2 to DynamicNameserver
2025-10-16T17:43:51.410909Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/connections"
2025-10-16T17:43:51.410963Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/connections": { <main>: Error: Check failed: path: '/local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/connections', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 81], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-10-16T17:43:51.411551Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/jobs"
2025-10-16T17:43:51.411606Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/jobs": { <main>: Error: Check failed: path: '/local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/jobs', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 85], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-10-16T17:43:51.413308Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/compute_databases"
2025-10-16T17:43:51.413400Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/compute_databases": { <main>: Error: Check failed: path: '/local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/compute_databases', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 79], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-10-16T17:43:51.413975Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/quotas"
2025-10-16T17:43:51.414035Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/quotas": { <main>: Error: Check failed: path: '/local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/quotas', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 82], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-10-16T17:43:51.415571Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/result_sets"
2025-10-16T17:43:51.415641Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/result_sets": { <main>: Error: Check failed: path: '/local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/result_sets', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 84], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-10-16T17:43:51.416023Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/mappings"
2025-10-16T17:43:51.416098Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/mappings": { <main>: Error: Check failed: path: '/local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/mappings', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 73], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-10-16T17:43:51.417654Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/queries"
2025-10-16T17:43:51.417704Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/queries": { <main>: Error: Check failed: path: '/local/DbPoolStorage_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/queries', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 83], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-10-16T17:43:51.471687Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:171: Successfully bootstrapped TStorageProxy [3:7561876751696558471:2066] with connection to localhost:27709:local
2025-10-16T17:43:52.270099Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: a8048d02-e55df7c7-7f02b4e6-b2ab40842, Host: ghrun-2kszfvc6cm, Tenant: /default
2025-10-16T17:43:52.297030Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-10-16T17:43:52.297062Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-10-16T17:43:52.306668Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:542: Coordinator: Send TEvGetNodesRequest to NodesManager
2025-10-16T17:43:52.306752Z :YQL_NODES_MANAGER DEBUG: nodes_manager.cpp:300: TNodesManagerActor::TEvGetNodesRequest
2025-10-16T17:43:52.306851Z :FQ_ROW_DISPATCHER INFO: coordinator.cpp:573: Coordinator: Updated node info, node count: 3
2025-10-16T17:43:52.312388Z :FQ_QUOTA_SERVICE DEBUG: quota_manager.cpp:230: IC Peers[2]: [1, 2]
2025-10-16T17:43:53.270286Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: a8048d02-e55df7c7-7f02b4e6-b2ab40843, Host: ghrun-2kszfvc6cm, Tenant: /default
2025-10-16T17:43:53.295688Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-10-16T17:43:53.295727Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-10-16T17:43:53.305576Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:620: RowDispatcher: Send ping to [1:7561876745496806031:2144]
2025-10-16T17:43:53.305624Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1164: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-10-16T17:43:54.270521Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: a8048d02-e55df7c7-7f02b4e6-b2ab40844, Host: ghrun-2kszfvc6cm, Tenant: /default
2025-10-16T17:43:54.297679Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-10-16T17:43:54.297716Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-10-16T17:43:54.323533Z :FQ_CONTROL_PLANE_CONFIG TRACE: control_plane_config.cpp:192: LOADED TenantInfo: State NOT changed
2025-10-16T17:43:55.270682Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: a8048d02-e55df7c7-7f02b4e6-b2ab40845, Host: ghrun-2kszfvc6cm, Tenant: /default
2025-10-16T17:43:55.295456Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-10-16T17:43:55.295482Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-10-16T17:43:55.305744Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:620: RowDispatcher: Send ping to [1:7561876745496806031:2144]
2025-10-16T17:43:55.305816Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1164: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-10-16T17:43:55.310155Z :INTERCONNECT WARN: interconnect_handshake.cpp:501: Handshake [3:7561876768876427778:2055] [node 1] ICH09 Neither CompatibilityInfo nor VersionTag of the peer can be validated, accepting by default
2025-10-16T17:43:55.312399Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:626: RowDispatcher: NActors::TEvents::TEvPong
2025-10-16T17:43:56.270890Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: a8048d02-e55df7c7-7f02b4e6-b2ab40846, Host: ghrun-2kszfvc6cm, Tenant: /default
2025-10-16T17:43:56.310827Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:318: TNodesManagerActor::NodesHealthCheck
2025-10-16T17:43:56.353762Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:389: Send NodeInfo with size: 3 to DynamicNameserver
2025-10-16T17:43:57.194796Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-10-16T17:43:57.194829Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-10-16T17:43:57.271016Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: a8048d02-e55df7c7-7f02b4e6-b2ab40847, Host: ghrun-2kszfvc6cm, Tenant: /default
2025-10-16T17:43:57.307080Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:620: RowDispatcher: Send ping to [1:7561876745496806031:2144]
2025-10-16T17:43:57.307191Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1164: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-10-16T17:43:57.307940Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:626: RowDispatcher: NActors::TEvents::TEvPong
2025-10-16T17:43:57.318288Z :FQ_QUOTA_SERVICE DEBUG: quota_manager.cpp:230: IC Peers[3]: [1, 2, 4]
2025-10-16T17:43:57.360792Z :FQ_CONTROL_PLANE_CONFIG TRACE: control_plane_config.cpp:192: LOADED TenantInfo: State NOT changed
2025-10-16T17:43:57.361155Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-10-16T17:43:57.361172Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-10-16T17:43:57.482722Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.cpuPercent.count=0/10000 UPDATE from Peer 1
2025-10-16T17:43:57.489532Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.analyticsQuery.count=0/100 UPDATE from Peer 1
2025-10-16T17:43:57.490771Z :INTERCONNECT WARN: interconnect_handshake.cpp:501: Handshake [3:7561876777466362382:2057] [node 4] ICH09 Neither CompatibilityInfo nor VersionTag of the peer can be validated, accepting by default
2025-10-16T17:43:57.492772Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.streamingQuery.count=0/100 UPDATE from Peer 1
2025-10-16T17:43:58.271291Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: a8048d02-e55df7c7-7f02b4e6-b2ab40848, Host: ghrun-2kszfvc6cm, Tenant: /default
2025-10-16T17:43:58.296543Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-10-16T17:43:58.296564Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-10-16T17:43:58.547572Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.cpuPercent.count=0/10000 UPDATE from Peer 1
2025-10-16T17:43:58.760763Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.streamingQuery.count=1/100 UPDATE from Peer 1
2025-10-16T17:43:58.760817Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.analyticsQuery.count=0/100 UPDATE from Peer 1
2025-10-16T17:43:58.811785Z :INTERCONNECT WARN: interconnect_handshake.cpp:501: Handshake [3:7561876781761329688:2060] [node 2] ICH09 Neither CompatibilityInfo nor VersionTag of the peer can be validated, accepting by default
2025-10-16T17:43:59.271470Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: a8048d02-e55df7c7-7f02b4e6-b2ab40849, Host: ghrun-2kszfvc6cm, Tenant: /default
2025-10-16T17:43:59.306830Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:620: RowDispatcher: Send ping to [1:7561876745496806031:2144]
2025-10-16T17:43:59.307215Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1164: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-10-16T17:43:59.307608Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:626: RowDispatcher: NActors::TEvents::TEvPong
2025-10-16T17:44:00.104999Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-10-16T17:44:00.105037Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-10-16T17:44:00.271652Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: a8048d02-e55df7c7-7f02b4e6-b2ab408410, Host: ghrun-2kszfvc6cm, Tenant: /default
2025-10-16T17:44:00.303961Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-10-16T17:44:00.303986Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-10-16T17:44:00.326892Z :FQ_CONTROL_PLANE_CONFIG TRACE: control_plane_config.cpp:192: LOADED TenantInfo: State NOT changed
2025-10-16T17:44:01.097533Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.cpuPercent.count=0/10000 UPDATE from Peer 1
2025-10-16T17:44:01.124362Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.analyticsQuery.count=0/100 UPDATE from Peer 1
2025-10-16T17:44:01.271824Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: a8048d02-e55df7c7-7f02b4e6-b2ab408411, Host: ghrun-2kszfvc6cm, Tenant: /default
2025-10-16T17:44:01.299397Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-10-16T17:44:01.299422Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-10-16T17:44:01.307122Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:620: RowDispatcher: Send ping to [1:7561876745496806031:2144]
2025-10-16T17:44:01.307332Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1164: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-10-16T17:44:01.307930Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:626: RowDispatcher: NActors::TEvents::TEvPong
2025-10-16T17:44:01.310932Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:318: TNodesManagerActor::NodesHealthCheck
2025-10-16T17:44:01.357197Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:389: Send NodeInfo with size: 3 to DynamicNameserver
2025-10-16T17:44:01.779162Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.streamingQuery.count=1/100 UPDATE from Peer 1
2025-10-16T17:44:02.150115Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:134: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Start compute actor [3:7561876798941198880:2157], task: 2
2025-10-16T17:44:02.150292Z :KQP_COMPUTE DEBUG: dq_async_compute_actor.cpp:113: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Use CPU quota: 1. Rate limiter resource: { "local/RateLimiter_1cb14e36-ad70-4822-a20f-ab9fca0ea7d1/rate_limiter", "mock_cloud/my_folder/ptqudumnbaa1nqamo756" }
2025-10-16T17:44:02.156541Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: a8048d02-e55df7c7-7f02b4e6-b2ab4084 2025-10-16 17:44:02.156 DEBUG ydbd(pid=1295718, tid=0x00007B9E8A623640) [DQ] tasks_runner_local.cpp:267: {TODO/2} Build task: 2
2025-10-16T17:44:02.157275Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: a8048d02-e55df7c7-7f02b4e6-b2ab4084 2025-10-16 17:44:02.157 DEBUG ydbd(pid=1295718, tid=0x00007B9E8A623640) [DQ] tasks_runner_local.cpp:267: {TODO/2} task: 2, program size: 6, llvm: ``.
2025-10-16T17:44:02.178901Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: a8048d02-e55df7c7-7f02b4e6-b2ab4084 2025-10-16 17:44:02.178 DEBUG ydbd(pid=1295718, tid=0x00007B9E8A623640) [DQ] tasks_runner_local.cpp:267: {TODO/2} Build task: 2 takes 22207 us
2025-10-16T17:44:02.179016Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: a8048d02-e55df7c7-7f02b4e6-b2ab4084 2025-10-16 17:44:02.178 DEBUG ydbd(pid=1295718, tid=0x00007B9E8A623640) [DQ] tasks_runner_local.cpp:267: {TODO/2} Prepare task: 2
2025-10-16T17:44:02.179217Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: a8048d02-e55df7c7-7f02b4e6-b2ab4084 2025-10-16 17:44:02.179 DEBUG ydbd(pid=1295718, tid=0x00007B9E8A623640) [DQ] tasks_runner_local.cpp:267: {TODO/2} Prepare task: 2, takes 92 us
2025-10-16T17:44:02.271984Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: a8048d02-e55df7c7-7f02b4e6-b2ab408412, Host: ghrun-2kszfvc6cm, Tenant: /default
2025-10-16T17:44:02.299620Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-10-16T17:44:02.299651Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-10-16T17:44:02.389174Z :KQP_COMPUTE DEBUG: dq_compute_actor_checkpoints.cpp:197: [] Task: 2. Got TEvNewCheckpointCoordinator event: generation 1, actorId: [1:7561876801331381170:2404]
2025-10-16T17:44:02.389196Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:208: [] Task: 2. Assign checkpoint coordinator (generation = 1)
2025-10-16T17:44:02.389510Z :KQP_COMPUTE DEBUG: dq_compute_actor_checkpoints.cpp:395: [ptqudumnbaa1nqamo756-0] Task: 2. Handle connected node 1
2025-10-16T17:44:02.536264Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:1074: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Received channels info: Update { Id: 1 TransportVersion: DATA_TRANSPORT_UV_PICKLE_1_0 SrcTaskId: 1 DstTaskId: 2 SrcEndpoint { ActorId { RawX1: 7561876801331381176 RawX2: 4503603922340202 } } DstEndpoint { ActorId { RawX1: 7561876798941198880 RawX2: 4503612512274541 } } SrcStageId: 200322 DstStageId: 200339 } Update { Id: 2 TransportVersion: DATA_TRANSPORT_UV_PICKLE_1_0 SrcTaskId: 2 SrcEndpoint { ActorId { RawX1: 7561876798941198880 RawX2: 4503612512274541 } } DstEndpoint { ActorId { RawX1: 7561876801331381169 RawX2: 4503603922340195 } } }
2025-10-16T17:44:02.536298Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:1081: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Update input channelId: 1, peer: [1:7561876801331381176:2410]
2025-10-16T17:44:02.536326Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:1093: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Update output channelId: 2, peer: [1:7561876801331381169:2403]
2025-10-16T17:44:03.113744Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:1169: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Got TEvRun from actor [1:7561876801331381170:2404]
2025-10-16T17:44:03.113837Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1486: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll inputs
2025-10-16T17:44:03.113873Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1501: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll sources
2025-10-16T17:44:03.113888Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:694: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-10-16T17:44:03.114184Z :KQP_COMPUTE TRACE: dq_compute_memory_quota.h:97: TxId: ptqudumnbaa1nqamo756, task: 2. Peak memory usage: 2031616
2025-10-16T17:44:03.114215Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:491: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. update task runner stats
2025-10-16T17:44:03.114301Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:758: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-10-16T17:44:03.114318Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:393: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-10-16T17:44:03.114349Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:532: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:1000000;inFlightBytes:0;inFlightCount:0;)
2025-10-16T17:44:03.114367Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:1105: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Ask CPU quota: 70ms
2025-10-16T17:44:03.114455Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:605: TxId: ptqudumnbaa1nqamo756, task: 2. no poll, channelId: 1, hasPeer: 1, finished: 0, retry: 0, lastSeqNo: 0, freeSpace: 1000000
2025-10-16T17:44:03.114683Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:129: TxId: ptqudumnbaa1nqamo756, task: 2. Received input for channelId: 1, seqNo: 1, size: 0, chunks: 0, watermark: 0, checkpoint: 1, finished: 0, from: [1:7561876801331381177:2410], expected seqNo: 1
2025-10-16T17:44:03.114710Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:609: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. took input
2025-10-16T17:44:03.114812Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:485: [ptqudumnbaa1nqamo756-0] Task: 2. [Checkpoint 1.1] Got checkpoint barrier from channel 1
2025-10-16T17:44:03.114871Z :DQ_TASK_RUNNER TRACE: task_runner_actor_local.cpp:395: SelfId: [3:7561876798941198882:2157], TxId: ptqudumnbaa1nqamo756, task: 2. No watermark 
2025-10-16T17:44:03.114891Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1486: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll inputs
2025-10-16T17:44:03.114905Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1497: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Skip polling sources because of pending checkpoint
2025-10-16T17:44:03.114922Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:694: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. DoExecuteImpl: 1
2025-10-16T17:44:03.114950Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:965: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Input data push finished. Cookie: 0 Watermark: (empty maybe) Ack: 1 TakeInputChannelDataRequests: 1
2025-10-16T17:44:03.114980Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:738: TxId: ptqudumnbaa1nqamo756, task: 2. Sending channel data ack to channelId: 1, peer: [1:7561876801331381176:2410], from: [3:7561876798941198880:2157], freeSpace: 1000000, seqNo: 1, finished: 0
2025-10-16T17:44:03.115030Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1486: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll inputs
2025-10-16T17:44:03.115042Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1497: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Skip polling sources because of pending checkpoint
2025-10-16T17:44:03.115050Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:694: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-10-16T17:44:03.124749Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:1162: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. CPU quota delay: 10ms
2025-10-16T17:44:03.124932Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: a8048d02-e55df7c7-7f02b4e6-b2ab4084 2025-10-16 17:44:03.124 DEBUG ydbd(pid=1295718, tid=0x00007B9E8A623640) [DQ] tasks_runner_local.cpp:267: {TODO/2} Run task: 2
2025-10-16T17:44:03.125035Z :DQ_TASK_RUNNER TRACE: task_runner_actor_local.cpp:510: SelfId: [3:7561876798941198882:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Pending 1 checkpoints to be sent
2025-10-16T17:44:03.125071Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:491: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. update task runner stats
2025-10-16T17:44:03.125201Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:758: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 1 watermark injected: (empty maybe)
2025-10-16T17:44:03.125228Z :KQP_COMPUTE DEBUG: dq_compute_actor_checkpoints.cpp:447: [ptqudumnbaa1nqamo756-0] Task: 2. [Checkpoint 1.1] Performing task checkpoint
2025-10-16T17:44:03.125242Z :KQP_COMPUTE DEBUG: dq_async_compute_actor.cpp:822: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Save state
2025-10-16T17:44:03.125254Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:474: [ptqudumnbaa1nqamo756-0] Task: 2. [Checkpoint 1.1] CA state saved
2025-10-16T17:44:03.125270Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:449: [ptqudumnbaa1nqamo756-0] Task: 2. [Checkpoint 1.1] Injecting checkpoint barrier to outputs
2025-10-16T17:44:03.125304Z :KQP_COMPUTE DEBUG: dq_compute_actor_checkpoints.cpp:536: [ptqudumnbaa1nqamo756-0] Task: 2. [Checkpoint 1.1] Task checkpoint is done. Send to storage
2025-10-16T17:44:03.125313Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:393: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-10-16T17:44:03.125334Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:532: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:1000000;inFlightBytes:0;inFlightCount:0;)
2025-10-16T17:44:03.125375Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:379: [ptqudumnbaa1nqamo756-0] [1:1] Got TEvSaveTaskState: task 2
2025-10-16T17:44:03.125402Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:566: TxId: ptqudumnbaa1nqamo756, task: 2. SendChannelData, channelId: 2, peer: [1:7561876801331381169:2403], chunks: 0, bytes: 0, watermark: 0, checkpoint: 1, seqNo: 1, finished: 0
2025-10-16T17:44:03.125488Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudumnbaa1nqamo756, task: 2. no poll, channelId: 1, has inflight messages: [1], last with freeSpace: 1000000, current freeSpace: 1000000
2025-10-16T17:44:03.125526Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1486: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll inputs
2025-10-16T17:44:03.125543Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1501: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll sources
2025-10-16T17:44:03.125553Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:694: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-10-16T17:44:03.125649Z :YQL_PROXY DEBUG: log.cpp:64: SessionId: a8048d02-e55df7c7-7f02b4e6-b2ab4084 2025-10-16 17:44:03.125 DEBUG ydbd(pid=1295718, tid=0x00007B9E8A623640) [DQ] tasks_runner_local.cpp:267: {TODO/2} Run task: 2
2025-10-16T17:44:03.125700Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:491: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. update task runner stats
2025-10-16T17:44:03.125754Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:758: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-10-16T17:44:03.125769Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:393: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-10-16T17:44:03.125787Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:532: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:1000000;inFlightBytes:96;inFlightCount:1;)
2025-10-16T17:44:03.125823Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudumnbaa1nqamo756, task: 2. no poll, channelId: 1, has inflight messages: [1], last with freeSpace: 1000000, current freeSpace: 1000000
2025-10-16T17:44:03.126264Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:179: TxId: ptqudumnbaa1nqamo756, task: 2. Received channel data ack for channelId: 2, seqNo: 1, lastSentSeqNo: 1, freeSpace: 67108864, early finish: 0
2025-10-16T17:44:03.126307Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:207: TxId: ptqudumnbaa1nqamo756, task: 2. PeerState, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;), sentSeqNo: 1, ackSeqNo: 1
2025-10-16T17:44:03.126328Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:220: TxId: ptqudumnbaa1nqamo756, task: 2. Resume compute actor
2025-10-16T17:44:03.126363Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1486: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll inputs
2025-10-16T17:44:03.126370Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1501: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll sources
2025-10-16T17:44:03.126379Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:694: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-10-16T17:44:03.126547Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:491: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. update task runner stats
2025-10-16T17:44:03.126628Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:758: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-10-16T17:44:03.126646Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:393: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-10-16T17:44:03.126667Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:532: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;)
2025-10-16T17:44:03.126740Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudumnbaa1nqamo756, task: 2. no poll, channelId: 1, has inflight messages: [1], last with freeSpace: 1000000, current freeSpace: 1000000
2025-10-16T17:44:03.151880Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.cpuPercent.count=0/10000 UPDATE from Peer 1
2025-10-16T17:44:03.170625Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.analyticsQuery.count=0/100 UPDATE from Peer 1
2025-10-16T17:44:03.171224Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.streamingQuery.count=1/100 UPDATE from Peer 1
2025-10-16T17:44:03.232858Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:403: [ptqudumnbaa1nqamo756-0] [1:1] TEvSaveTaskState Apply: task: 2
2025-10-16T17:44:03.232888Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:418: [ptqudumnbaa1nqamo756-0] [1:1] Send TEvSaveTaskStateResult: task: 2
2025-10-16T17:44:03.272216Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: a8048d02-e55df7c7-7f02b4e6-b2ab408413, Host: ghrun-2kszfvc6cm, Tenant: /default
2025-10-16T17:44:03.299380Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-10-16T17:44:03.299406Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-10-16T17:44:03.307252Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:620: RowDispatcher: Send ping to [1:7561876745496806031:2144]
2025-10-16T17:44:03.307545Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1164: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-10-16T17:44:03.307920Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:626: RowDispatcher: NActors::TEvents::TEvPong
2025-10-16T17:44:03.322369Z :FQ_CONTROL_PLANE_CONFIG TRACE: control_plane_config.cpp:192: LOADED TenantInfo: State NOT changed
2025-10-16T17:44:04.272397Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: a8048d02-e55df7c7-7f02b4e6-b2ab408414, Host: ghrun-2kszfvc6cm, Tenant: /default
2025-10-16T17:44:04.296896Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-10-16T17:44:04.296917Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-10-16T17:44:04.685273Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:129: TxId: ptqudumnbaa1nqamo756, task: 2. Received input for channelId: 1, seqNo: 2, size: 0, chunks: 0, watermark: 0, checkpoint: 1, finished: 0, from: [1:7561876801331381177:2410], expected seqNo: 2
2025-10-16T17:44:04.685299Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:609: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. took input
2025-10-16T17:44:04.685354Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:485: [ptqudumnbaa1nqamo756-0] Task: 2. [Checkpoint 1.2] Got checkpoint barrier from channel 1
2025-10-16T17:44:04.685423Z :DQ_TASK_RUNNER TRACE: task_runner_actor_local.cpp:395: SelfId: [3:7561876798941198882:2157], TxId: ptqudumnbaa1nqamo756, task: 2. No watermark 
2025-10-16T17:44:04.685440Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1486: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll inputs
2025-10-16T17:44:04.685447Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1497: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Skip polling sources because of pending checkpoint
2025-10-16T17:44:04.685456Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:694: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. DoExecuteImpl: 1
2025-10-16T17:44:04.685479Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:965: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Input data push finished. Cookie: 1 Watermark: (empty maybe) Ack: 1 TakeInputChannelDataRequests: 1
2025-10-16T17:44:04.685499Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:738: TxId: ptqudumnbaa1nqamo756, task: 2. Sending channel data ack to channelId: 1, peer: [1:7561876801331381176:2410], from: [3:7561876798941198880:2157], freeSpace: 1000000, seqNo: 2, finished: 0
2025-10-16T17:44:04.685722Z :DQ_TASK_RUNNER TRACE: task_runner_actor_local.cpp:510: SelfId: [3:7561876798941198882:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Pending 1 checkpoints to be sent
2025-10-16T17:44:04.685761Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1486: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll inputs
2025-10-16T17:44:04.685767Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1497: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Skip polling sources because of pending checkpoint
2025-10-16T17:44:04.685773Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:694: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-10-16T17:44:04.685785Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:491: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. update task runner stats
2025-10-16T17:44:04.685882Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:758: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 1 watermark injected: (empty maybe)
2025-10-16T17:44:04.685903Z :KQP_COMPUTE DEBUG: dq_compute_actor_checkpoints.cpp:447: [ptqudumnbaa1nqamo756-0] Task: 2. [Checkpoint 1.2] Performing task checkpoint
2025-10-16T17:44:04.685911Z :KQP_COMPUTE DEBUG: dq_async_compute_actor.cpp:822: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Save state
2025-10-16T17:44:04.685933Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:474: [ptqudumnbaa1nqamo756-0] Task: 2. [Checkpoint 1.2] CA state saved
2025-10-16T17:44:04.685944Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:449: [ptqudumnbaa1nqamo756-0] Task: 2. [Checkpoint 1.2] Injecting checkpoint barrier to outputs
2025-10-16T17:44:04.685971Z :KQP_COMPUTE DEBUG: dq_compute_actor_checkpoints.cpp:536: [ptqudumnbaa1nqamo756-0] Task: 2. [Checkpoint 1.2] Task checkpoint is done. Send to storage
2025-10-16T17:44:04.685979Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:393: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-10-16T17:44:04.685996Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:532: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;)
2025-10-16T17:44:04.686024Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:379: [ptqudumnbaa1nqamo756-0] [1:2] Got TEvSaveTaskState: task 2
2025-10-16T17:44:04.686154Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:566: TxId: ptqudumnbaa1nqamo756, task: 2. SendChannelData, channelId: 2, peer: [1:7561876801331381169:2403], chunks: 0, bytes: 0, watermark: 0, checkpoint: 1, seqNo: 2, finished: 0
2025-10-16T17:44:04.686210Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudumnbaa1nqamo756, task: 2. no poll, channelId: 1, has inflight messages: [2], last with freeSpace: 1000000, current freeSpace: 1000000
2025-10-16T17:44:04.686224Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:491: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. update task runner stats
2025-10-16T17:44:04.686282Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:758: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-10-16T17:44:04.686292Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:393: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-10-16T17:44:04.686308Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:532: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:96;inFlightCount:1;)
2025-10-16T17:44:04.686356Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1486: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll inputs
2025-10-16T17:44:04.686366Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1501: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll sources
2025-10-16T17:44:04.686373Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:694: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-10-16T17:44:04.686532Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudumnbaa1nqamo756, task: 2. no poll, channelId: 1, has inflight messages: [2], last with freeSpace: 1000000, current freeSpace: 1000000
2025-10-16T17:44:04.686553Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:491: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. update task runner stats
2025-10-16T17:44:04.686595Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:758: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-10-16T17:44:04.686602Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:393: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-10-16T17:44:04.686616Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:532: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:96;inFlightCount:1;)
2025-10-16T17:44:04.686651Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudumnbaa1nqamo756, task: 2. no poll, channelId: 1, has inflight messages: [2], last with freeSpace: 1000000, current freeSpace: 1000000
2025-10-16T17:44:04.686678Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:179: TxId: ptqudumnbaa1nqamo756, task: 2. Received channel data ack for channelId: 2, seqNo: 2, lastSentSeqNo: 2, freeSpace: 67108864, early finish: 0
2025-10-16T17:44:04.686697Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:207: TxId: ptqudumnbaa1nqamo756, task: 2. PeerState, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;), sentSeqNo: 2, ackSeqNo: 2
2025-10-16T17:44:04.686704Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:220: TxId: ptqudumnbaa1nqamo756, task: 2. Resume compute actor
2025-10-16T17:44:04.686737Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1486: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll inputs
2025-10-16T17:44:04.686744Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1501: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll sources
2025-10-16T17:44:04.686751Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:694: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-10-16T17:44:04.686865Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:491: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. update task runner stats
2025-10-16T17:44:04.686914Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:758: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-10-16T17:44:04.686928Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:393: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-10-16T17:44:04.686957Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:532: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;)
2025-10-16T17:44:04.686994Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudumnbaa1nqamo756, task: 2. no poll, channelId: 1, has inflight messages: [2], last with freeSpace: 1000000, current freeSpace: 1000000
2025-10-16T17:44:04.700526Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:403: [ptqudumnbaa1nqamo756-0] [1:2] TEvSaveTaskState Apply: task: 2
2025-10-16T17:44:04.700556Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:418: [ptqudumnbaa1nqamo756-0] [1:2] Send TEvSaveTaskStateResult: task: 2
2025-10-16T17:44:05.272615Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: a8048d02-e55df7c7-7f02b4e6-b2ab408415, Host: ghrun-2kszfvc6cm, Tenant: /default
2025-10-16T17:44:05.299639Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-10-16T17:44:05.299666Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-10-16T17:44:05.307368Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:620: RowDispatcher: Send ping to [1:7561876745496806031:2144]
2025-10-16T17:44:05.307566Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1164: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-10-16T17:44:05.308005Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:626: RowDispatcher: NActors::TEvents::TEvPong
2025-10-16T17:44:05.453105Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:129: TxId: ptqudumnbaa1nqamo756, task: 2. Received input for channelId: 1, seqNo: 3, size: 0, chunks: 0, watermark: 0, checkpoint: 1, finished: 0, from: [1:7561876801331381177:2410], expected seqNo: 3
2025-10-16T17:44:05.453141Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:609: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. took input
2025-10-16T17:44:05.453185Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:485: [ptqudumnbaa1nqamo756-0] Task: 2. [Checkpoint 1.3] Got checkpoint barrier from channel 1
2025-10-16T17:44:05.453247Z :DQ_TASK_RUNNER TRACE: task_runner_actor_local.cpp:395: SelfId: [3:7561876798941198882:2157], TxId: ptqudumnbaa1nqamo756, task: 2. No watermark 
2025-10-16T17:44:05.453263Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1486: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll inputs
2025-10-16T17:44:05.453278Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1497: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Skip polling sources because of pending checkpoint
2025-10-16T17:44:05.453286Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:694: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. DoExecuteImpl: 1
2025-10-16T17:44:05.453311Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:965: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Input data push finished. Cookie: 2 Watermark: (empty maybe) Ack: 1 TakeInputChannelDataRequests: 1
2025-10-16T17:44:05.453334Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:738: TxId: ptqudumnbaa1nqamo756, task: 2. Sending channel data ack to channelId: 1, peer: [1:7561876801331381176:2410], from: [3:7561876798941198880:2157], freeSpace: 1000000, seqNo: 3, finished: 0
2025-10-16T17:44:05.453578Z :DQ_TASK_RUNNER TRACE: task_runner_actor_local.cpp:510: SelfId: [3:7561876798941198882:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Pending 1 checkpoints to be sent
2025-10-16T17:44:05.453607Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1486: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll inputs
2025-10-16T17:44:05.453614Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1497: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Skip polling sources because of pending checkpoint
2025-10-16T17:44:05.453625Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:694: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-10-16T17:44:05.453636Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:491: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. update task runner stats
2025-10-16T17:44:05.453715Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:758: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 1 watermark injected: (empty maybe)
2025-10-16T17:44:05.453733Z :KQP_COMPUTE DEBUG: dq_compute_actor_checkpoints.cpp:447: [ptqudumnbaa1nqamo756-0] Task: 2. [Checkpoint 1.3] Performing task checkpoint
2025-10-16T17:44:05.453740Z :KQP_COMPUTE DEBUG: dq_async_compute_actor.cpp:822: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Save state
2025-10-16T17:44:05.453750Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:474: [ptqudumnbaa1nqamo756-0] Task: 2. [Checkpoint 1.3] CA state saved
2025-10-16T17:44:05.453760Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:449: [ptqudumnbaa1nqamo756-0] Task: 2. [Checkpoint 1.3] Injecting checkpoint barrier to outputs
2025-10-16T17:44:05.453784Z :KQP_COMPUTE DEBUG: dq_compute_actor_checkpoints.cpp:536: [ptqudumnbaa1nqamo756-0] Task: 2. [Checkpoint 1.3] Task checkpoint is done. Send to storage
2025-10-16T17:44:05.453793Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:393: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-10-16T17:44:05.453814Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:532: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;)
2025-10-16T17:44:05.453864Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:379: [ptqudumnbaa1nqamo756-0] [1:3] Got TEvSaveTaskState: task 2
2025-10-16T17:44:05.453951Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:566: TxId: ptqudumnbaa1nqamo756, task: 2. SendChannelData, channelId: 2, peer: [1:7561876801331381169:2403], chunks: 0, bytes: 0, watermark: 0, checkpoint: 1, seqNo: 3, finished: 0
2025-10-16T17:44:05.454002Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudumnbaa1nqamo756, task: 2. no poll, channelId: 1, has inflight messages: [3], last with freeSpace: 1000000, current freeSpace: 1000000
2025-10-16T17:44:05.454015Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:491: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. update task runner stats
2025-10-16T17:44:05.454052Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:758: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-10-16T17:44:05.454071Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:393: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-10-16T17:44:05.454107Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:532: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:96;inFlightCount:1;)
2025-10-16T17:44:05.454131Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1486: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll inputs
2025-10-16T17:44:05.454139Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1501: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll sources
2025-10-16T17:44:05.454144Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:694: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-10-16T17:44:05.454263Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudumnbaa1nqamo756, task: 2. no poll, channelId: 1, has inflight messages: [3], last with freeSpace: 1000000, current freeSpace: 1000000
2025-10-16T17:44:05.454276Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:491: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. update task runner stats
2025-10-16T17:44:05.454328Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:758: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-10-16T17:44:05.454341Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:393: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-10-16T17:44:05.454352Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:532: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:96;inFlightCount:1;)
2025-10-16T17:44:05.454390Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudumnbaa1nqamo756, task: 2. no poll, channelId: 1, has inflight messages: [3], last with freeSpace: 1000000, current freeSpace: 1000000
2025-10-16T17:44:05.455776Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:179: TxId: ptqudumnbaa1nqamo756, task: 2. Received channel data ack for channelId: 2, seqNo: 3, lastSentSeqNo: 3, freeSpace: 67108864, early finish: 0
2025-10-16T17:44:05.455810Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:207: TxId: ptqudumnbaa1nqamo756, task: 2. PeerState, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;), sentSeqNo: 3, ackSeqNo: 3
2025-10-16T17:44:05.455818Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:220: TxId: ptqudumnbaa1nqamo756, task: 2. Resume compute actor
2025-10-16T17:44:05.455837Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1486: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll inputs
2025-10-16T17:44:05.455843Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1501: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll sources
2025-10-16T17:44:05.455869Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:694: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-10-16T17:44:05.456086Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:491: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. update task runner stats
2025-10-16T17:44:05.456142Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:758: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-10-16T17:44:05.456154Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:393: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-10-16T17:44:05.456178Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:532: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;)
2025-10-16T17:44:05.456218Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudumnbaa1nqamo756, task: 2. no poll, channelId: 1, has inflight messages: [3], last with freeSpace: 1000000, current freeSpace: 1000000
2025-10-16T17:44:05.468887Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:403: [ptqudumnbaa1nqamo756-0] [1:3] TEvSaveTaskState Apply: task: 2
2025-10-16T17:44:05.468919Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:418: [ptqudumnbaa1nqamo756-0] [1:3] Send TEvSaveTaskStateResult: task: 2
2025-10-16T17:44:05.818973Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.cpuPercent.count=0/10000 UPDATE from Peer 1
2025-10-16T17:44:05.844004Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.analyticsQuery.count=0/100 UPDATE from Peer 1
2025-10-16T17:44:05.844054Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.streamingQuery.count=1/100 UPDATE from Peer 1
2025-10-16T17:44:06.272767Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: a8048d02-e55df7c7-7f02b4e6-b2ab408416, Host: ghrun-2kszfvc6cm, Tenant: /default
2025-10-16T17:44:06.299566Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-10-16T17:44:06.299614Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-10-16T17:44:06.311186Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:318: TNodesManagerActor::NodesHealthCheck
2025-10-16T17:44:06.324186Z :FQ_CONTROL_PLANE_CONFIG TRACE: control_plane_config.cpp:192: LOADED TenantInfo: State NOT changed
2025-10-16T17:44:06.355944Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:389: Send NodeInfo with size: 3 to DynamicNameserver
2025-10-16T17:44:06.442000Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:129: TxId: ptqudumnbaa1nqamo756, task: 2. Received input for channelId: 1, seqNo: 4, size: 0, chunks: 0, watermark: 0, checkpoint: 1, finished: 0, from: [1:7561876801331381177:2410], expected seqNo: 4
2025-10-16T17:44:06.442027Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:609: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. took input
2025-10-16T17:44:06.442088Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:485: [ptqudumnbaa1nqamo756-0] Task: 2. [Checkpoint 1.4] Got checkpoint barrier from channel 1
2025-10-16T17:44:06.442137Z :DQ_TASK_RUNNER TRACE: task_runner_actor_local.cpp:395: SelfId: [3:7561876798941198882:2157], TxId: ptqudumnbaa1nqamo756, task: 2. No watermark 
2025-10-16T17:44:06.442153Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1486: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll inputs
2025-10-16T17:44:06.442160Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1497: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Skip polling sources because of pending checkpoint
2025-10-16T17:44:06.442175Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:694: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. DoExecuteImpl: 1
2025-10-16T17:44:06.442198Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:965: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Input data push finished. Cookie: 3 Watermark: (empty maybe) Ack: 1 TakeInputChannelDataRequests: 1
2025-10-16T17:44:06.442218Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:738: TxId: ptqudumnbaa1nqamo756, task: 2. Sending channel data ack to channelId: 1, peer: [1:7561876801331381176:2410], from: [3:7561876798941198880:2157], freeSpace: 1000000, seqNo: 4, finished: 0
2025-10-16T17:44:06.442431Z :DQ_TASK_RUNNER TRACE: task_runner_actor_local.cpp:510: SelfId: [3:7561876798941198882:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Pending 1 checkpoints to be sent
2025-10-16T17:44:06.442463Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1486: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll inputs
2025-10-16T17:44:06.442469Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1497: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Skip polling sources because of pending checkpoint
2025-10-16T17:44:06.442475Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:694: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-10-16T17:44:06.442490Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:491: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. update task runner stats
2025-10-16T17:44:06.442556Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:758: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 1 watermark injected: (empty maybe)
2025-10-16T17:44:06.442580Z :KQP_COMPUTE DEBUG: dq_compute_actor_checkpoints.cpp:447: [ptqudumnbaa1nqamo756-0] Task: 2. [Checkpoint 1.4] Performing task checkpoint
2025-10-16T17:44:06.442587Z :KQP_COMPUTE DEBUG: dq_async_compute_actor.cpp:822: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Save state
2025-10-16T17:44:06.442597Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:474: [ptqudumnbaa1nqamo756-0] Task: 2. [Checkpoint 1.4] CA state saved
2025-10-16T17:44:06.442606Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:449: [ptqudumnbaa1nqamo756-0] Task: 2. [Checkpoint 1.4] Injecting checkpoint barrier to outputs
2025-10-16T17:44:06.442629Z :KQP_COMPUTE DEBUG: dq_compute_actor_checkpoints.cpp:536: [ptqudumnbaa1nqamo756-0] Task: 2. [Checkpoint 1.4] Task checkpoint is done. Send to storage
2025-10-16T17:44:06.442636Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:393: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-10-16T17:44:06.442655Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:532: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;)
2025-10-16T17:44:06.442691Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:379: [ptqudumnbaa1nqamo756-0] [1:4] Got TEvSaveTaskState: task 2
2025-10-16T17:44:06.442844Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:566: TxId: ptqudumnbaa1nqamo756, task: 2. SendChannelData, channelId: 2, peer: [1:7561876801331381169:2403], chunks: 0, bytes: 0, watermark: 0, checkpoint: 1, seqNo: 4, finished: 0
2025-10-16T17:44:06.442897Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudumnbaa1nqamo756, task: 2. no poll, channelId: 1, has inflight messages: [4], last with freeSpace: 1000000, current freeSpace: 1000000
2025-10-16T17:44:06.442911Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:491: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. update task runner stats
2025-10-16T17:44:06.442966Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:758: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-10-16T17:44:06.442976Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:393: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-10-16T17:44:06.442989Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:532: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:96;inFlightCount:1;)
2025-10-16T17:44:06.443007Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1486: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll inputs
2025-10-16T17:44:06.443012Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1501: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll sources
2025-10-16T17:44:06.443016Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:694: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-10-16T17:44:06.443127Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudumnbaa1nqamo756, task: 2. no poll, channelId: 1, has inflight messages: [4], last with freeSpace: 1000000, current freeSpace: 1000000
2025-10-16T17:44:06.443143Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:491: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. update task runner stats
2025-10-16T17:44:06.443180Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:758: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-10-16T17:44:06.443197Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:393: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-10-16T17:44:06.443210Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:532: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:96;inFlightCount:1;)
2025-10-16T17:44:06.443236Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudumnbaa1nqamo756, task: 2. no poll, channelId: 1, has inflight messages: [4], last with freeSpace: 1000000, current freeSpace: 1000000
2025-10-16T17:44:06.443355Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:179: TxId: ptqudumnbaa1nqamo756, task: 2. Received channel data ack for channelId: 2, seqNo: 4, lastSentSeqNo: 4, freeSpace: 67108864, early finish: 0
2025-10-16T17:44:06.443379Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:207: TxId: ptqudumnbaa1nqamo756, task: 2. PeerState, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;), sentSeqNo: 4, ackSeqNo: 4
2025-10-16T17:44:06.443387Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:220: TxId: ptqudumnbaa1nqamo756, task: 2. Resume compute actor
2025-10-16T17:44:06.443400Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1486: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll inputs
2025-10-16T17:44:06.443404Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1501: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll sources
2025-10-16T17:44:06.443408Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:694: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-10-16T17:44:06.443526Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:491: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. update task runner stats
2025-10-16T17:44:06.443572Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:758: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-10-16T17:44:06.443583Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:393: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-10-16T17:44:06.443599Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:532: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;)
2025-10-16T17:44:06.443632Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudumnbaa1nqamo756, task: 2. no poll, channelId: 1, has inflight messages: [4], last with freeSpace: 1000000, current freeSpace: 1000000
2025-10-16T17:44:06.458990Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:403: [ptqudumnbaa1nqamo756-0] [1:4] TEvSaveTaskState Apply: task: 2
2025-10-16T17:44:06.459022Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:418: [ptqudumnbaa1nqamo756-0] [1:4] Send TEvSaveTaskStateResult: task: 2
2025-10-16T17:44:07.272930Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: a8048d02-e55df7c7-7f02b4e6-b2ab408417, Host: ghrun-2kszfvc6cm, Tenant: /default
2025-10-16T17:44:07.273309Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:451: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Got TEvStateRequest from actor [1:7561876801331381171:2405] PingCookie: 1
2025-10-16T17:44:07.273416Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:491: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. update task runner stats
2025-10-16T17:44:07.297808Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-10-16T17:44:07.297834Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-10-16T17:44:07.307502Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:620: RowDispatcher: Send ping to [1:7561876745496806031:2144]
2025-10-16T17:44:07.307727Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1164: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-10-16T17:44:07.308159Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:626: RowDispatcher: NActors::TEvents::TEvPong
2025-10-16T17:44:07.440072Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:129: TxId: ptqudumnbaa1nqamo756, task: 2. Received input for channelId: 1, seqNo: 5, size: 0, chunks: 0, watermark: 0, checkpoint: 1, finished: 0, from: [1:7561876801331381177:2410], expected seqNo: 5
2025-10-16T17:44:07.440098Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:609: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. took input
2025-10-16T17:44:07.440147Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:485: [ptqudumnbaa1nqamo756-0] Task: 2. [Checkpoint 1.5] Got checkpoint barrier from channel 1
2025-10-16T17:44:07.440200Z :DQ_TASK_RUNNER TRACE: task_runner_actor_local.cpp:395: SelfId: [3:7561876798941198882:2157], TxId: ptqudumnbaa1nqamo756, task: 2. No watermark 
2025-10-16T17:44:07.440221Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1486: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll inputs
2025-10-16T17:44:07.440228Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1497: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Skip polling sources because of pending checkpoint
2025-10-16T17:44:07.440237Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:694: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. DoExecuteImpl: 1
2025-10-16T17:44:07.440257Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:965: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Input data push finished. Cookie: 4 Watermark: (empty maybe) Ack: 1 TakeInputChannelDataRequests: 1
2025-10-16T17:44:07.440278Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:738: TxId: ptqudumnbaa1nqamo756, task: 2. Sending channel data ack to channelId: 1, peer: [1:7561876801331381176:2410], from: [3:7561876798941198880:2157], freeSpace: 1000000, seqNo: 5, finished: 0
2025-10-16T17:44:07.440517Z :DQ_TASK_RUNNER TRACE: task_runner_actor_local.cpp:510: SelfId: [3:7561876798941198882:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Pending 1 checkpoints to be sent
2025-10-16T17:44:07.440545Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1486: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll inputs
2025-10-16T17:44:07.440551Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1497: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Skip polling sources because of pending checkpoint
2025-10-16T17:44:07.440557Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:694: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-10-16T17:44:07.440566Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:491: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. update task runner stats
2025-10-16T17:44:07.440616Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:758: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 1 watermark injected: (empty maybe)
2025-10-16T17:44:07.440625Z :KQP_COMPUTE DEBUG: dq_compute_actor_checkpoints.cpp:447: [ptqudumnbaa1nqamo756-0] Task: 2. [Checkpoint 1.5] Performing task checkpoint
2025-10-16T17:44:07.440631Z :KQP_COMPUTE DEBUG: dq_async_compute_actor.cpp:822: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Save state
2025-10-16T17:44:07.440656Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:474: [ptqudumnbaa1nqamo756-0] Task: 2. [Checkpoint 1.5] CA state saved
2025-10-16T17:44:07.440665Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:449: [ptqudumnbaa1nqamo756-0] Task: 2. [Checkpoint 1.5] Injecting checkpoint barrier to outputs
2025-10-16T17:44:07.440694Z :KQP_COMPUTE DEBUG: dq_compute_actor_checkpoints.cpp:536: [ptqudumnbaa1nqamo756-0] Task: 2. [Checkpoint 1.5] Task checkpoint is done. Send to storage
2025-10-16T17:44:07.440701Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:393: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-10-16T17:44:07.440713Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:532: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;)
2025-10-16T17:44:07.440738Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:379: [ptqudumnbaa1nqamo756-0] [1:5] Got TEvSaveTaskState: task 2
2025-10-16T17:44:07.440864Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:566: TxId: ptqudumnbaa1nqamo756, task: 2. SendChannelData, channelId: 2, peer: [1:7561876801331381169:2403], chunks: 0, bytes: 0, watermark: 0, checkpoint: 1, seqNo: 5, finished: 0
2025-10-16T17:44:07.440916Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudumnbaa1nqamo756, task: 2. no poll, channelId: 1, has inflight messages: [5], last with freeSpace: 1000000, current freeSpace: 1000000
2025-10-16T17:44:07.440935Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:491: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. update task runner stats
2025-10-16T17:44:07.440983Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:758: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-10-16T17:44:07.440991Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:393: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-10-16T17:44:07.441005Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:532: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:96;inFlightCount:1;)
2025-10-16T17:44:07.441021Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1486: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll inputs
2025-10-16T17:44:07.441029Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1501: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll sources
2025-10-16T17:44:07.441036Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:694: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-10-16T17:44:07.441176Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudumnbaa1nqamo756, task: 2. no poll, channelId: 1, has inflight messages: [5], last with freeSpace: 1000000, current freeSpace: 1000000
2025-10-16T17:44:07.441191Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:491: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. update task runner stats
2025-10-16T17:44:07.441229Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:758: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-10-16T17:44:07.441241Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:393: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-10-16T17:44:07.441255Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:532: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:96;inFlightCount:1;)
2025-10-16T17:44:07.441283Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudumnbaa1nqamo756, task: 2. no poll, channelId: 1, has inflight messages: [5], last with freeSpace: 1000000, current freeSpace: 1000000
2025-10-16T17:44:07.441436Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:179: TxId: ptqudumnbaa1nqamo756, task: 2. Received channel data ack for channelId: 2, seqNo: 5, lastSentSeqNo: 5, freeSpace: 67108864, early finish: 0
2025-10-16T17:44:07.441460Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:207: TxId: ptqudumnbaa1nqamo756, task: 2. PeerState, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;), sentSeqNo: 5, ackSeqNo: 5
2025-10-16T17:44:07.441468Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:220: TxId: ptqudumnbaa1nqamo756, task: 2. Resume compute actor
2025-10-16T17:44:07.441482Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1486: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll inputs
2025-10-16T17:44:07.441488Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1501: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Poll sources
2025-10-16T17:44:07.441496Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:694: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-10-16T17:44:07.441627Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:491: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. update task runner stats
2025-10-16T17:44:07.441682Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:758: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-10-16T17:44:07.441696Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:393: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-10-16T17:44:07.441711Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:532: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;)
2025-10-16T17:44:07.441748Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudumnbaa1nqamo756, task: 2. no poll, channelId: 1, has inflight messages: [5], last with freeSpace: 1000000, current freeSpace: 1000000
2025-10-16T17:44:07.454813Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:403: [ptqudumnbaa1nqamo756-0] [1:5] TEvSaveTaskState Apply: task: 2
2025-10-16T17:44:07.454865Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:418: [ptqudumnbaa1nqamo756-0] [1:5] Send TEvSaveTaskStateResult: task: 2
2025-10-16T17:44:07.564437Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.cpuPercent.count=0/10000 UPDATE from Peer 1
2025-10-16T17:44:07.572968Z :KQP_COMPUTE ERROR: dq_compute_actor_impl.h:1210: SelfId: [3:7561876798941198880:2157], TxId: ptqudumnbaa1nqamo756, task: 2. Ctx: {}. Handle abort execution event from: [3:7561876751696558473:2068], status: UNAVAILABLE, reason: { <main>: Error: Aborted by LWM }
2025-10-16T17:44:07.573099Z :KQP_COMPUTE DEBUG: dq_compute_actor_channels.cpp:494: TxId: ptqudumnbaa1nqamo756, task: 2. pass away
2025-10-16T17:44:07.583858Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.streamingQuery.count=1/100 UPDATE from Peer 1
2025-10-16T17:44:07.585253Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.analyticsQuery.count=0/100 UPDATE from Peer 1
2025-10-16T17:44:08.273216Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: a8048d02-e55df7c7-7f02b4e6-b2ab408418, Host: ghrun-2kszfvc6cm, Tenant: /default
2025-10-16T17:44:08.331548Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-10-16T17:44:08.331579Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-10-16T17:44:09.273416Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: a8048d02-e55df7c7-7f02b4e6-b2ab408419, Host: ghrun-2kszfvc6cm, Tenant: /default
2025-10-16T17:44:09.296378Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-10-16T17:44:09.296412Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-10-16T17:44:09.307614Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:620: RowDispatcher: Send ping to [1:7561876745496806031:2144]
2025-10-16T17:44:09.307844Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1164: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-10-16T17:44:09.308249Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:626: RowDispatcher: NActors::TEvents::TEvPong
2025-10-16T17:44:09.322283Z :FQ_CONTROL_PLANE_CONFIG TRACE: control_plane_config.cpp:192: LOADED TenantInfo: State NOT changed
2025-10-16T17:44:09.610135Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.cpuPercent.count=0/10000 UPDATE from Peer 1
2025-10-16T17:44:09.618347Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.analyticsQuery.count=0/100 UPDATE from Peer 1
2025-10-16T17:44:09.619373Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.streamingQuery.count=0/100 UPDATE from Peer 1
2025-10-16T17:44:09.620818Z :INTERCONNECT_NETWORK NOTICE: interconnect_tcp_input_session.cpp:712: [3 <-> 4] connection closed by peer
