2025-12-24T15:59:46.237143Z :YQL_NODES_MANAGER INFO: nodes_manager.cpp:88: Bootstrap, InstanceId: 6492f84-4a0e7183-664c128a-c806c9b1
2025-12-24T15:59:46.237153Z :YQL_NODES_MANAGER DEBUG: nodes_manager.cpp:310: TNodesManagerActor::ResolveSelfAddress
2025-12-24T15:59:46.237932Z :GRPC_SERVER NOTICE: grpc_request_proxy_simple.cpp:161: Grpc simple request proxy started, nodeid# 2
2025-12-24T15:59:46.238380Z :GRPC_SERVER NOTICE: grpc_request_proxy_simple.cpp:161: Grpc simple request proxy started, nodeid# 2
2025-12-24T15:59:46.239218Z :FQ_CONTROL_PLANE_CONFIG DEBUG: control_plane_config.cpp:58: STARTING: [2:7587454807644673521:2061]
2025-12-24T15:59:46.241794Z :YQ_TEST_CONNECTION DEBUG: test_connection.cpp:142: Starting yandex query test connection. Actor id: [2:7587454807644673532:2072]
2025-12-24T15:59:46.242440Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: fe4efe5e-f6177e5c-9b4fb240-b16b6f71, Host: ghrun-4wztbyq45u, Tenant: /default
2025-12-24T15:59:46.242668Z :FQ_LOG_UPDATER DEBUG: log.cpp:93: Updated YQL logs priority: 8
2025-12-24T15:59:46.242714Z :FQ_LOG_UPDATER CRIT: log.cpp:55: Failed to deliver subscription request to config dispatcher.
2025-12-24T15:59:46.242806Z :YQ_CONTROL_PLANE_STORAGE INFO: ydb_control_plane_storage.cpp:50: Starting ydb control plane storage service. Actor id: [2:7587454807644673520:2060]
2025-12-24T15:59:46.243496Z :MEMORY_PROFILER NOTICE: monitor.cpp:332: Bootstrapped
2025-12-24T15:59:46.266997Z :FQ_QUOTA_SERVICE INFO: quota_manager.cpp:196: STARTED
2025-12-24T15:59:46.268607Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/idempotency_keys" actor
2025-12-24T15:59:46.271164Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/result_sets" actor
2025-12-24T15:59:46.271221Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/jobs" actor
2025-12-24T15:59:46.271270Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/nodes" actor
2025-12-24T15:59:46.271319Z :FQ_QUOTA_PROXY INFO: quota_proxy.cpp:90: STARTED
2025-12-24T15:59:46.271331Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/tenants" actor
2025-12-24T15:59:46.271371Z :YQ_CONTROL_PLANE_PROXY DEBUG: control_plane_proxy.cpp:525: Starting yandex query control plane proxy. Actor id: [2:7587454807644673522:2062]
2025-12-24T15:59:46.273251Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/tenant_acks" actor
2025-12-24T15:59:46.273806Z :YQ_RATE_LIMITER INFO: quoter_service.cpp:124: Bootstraping with config: { Enabled: true ControlPlaneEnabled: true DataPlaneEnabled: true Database { Endpoint: "localhost:62782" Database: "local" TablePrefix: "RateLimiter_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc" } Limiters { CoordinationNodePath: "rate_limiter" } }
2025-12-24T15:59:46.274730Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/compute_databases" actor
2025-12-24T15:59:46.274930Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:214: Bootstrap
2025-12-24T15:59:46.274941Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:217: Create sdk ydb connection
2025-12-24T15:59:46.275107Z :STREAMS_STORAGE_SERVICE INFO: storage_proxy.cpp:239: Successfully bootstrapped TStorageProxy [2:7587454807644673526:2066] with connection to localhost:62782:local
2025-12-24T15:59:46.275126Z :FQ_ROW_DISPATCHER DEBUG: row_dispatcher.cpp:544: RowDispatcher: Successfully bootstrapped row dispatcher, id [2:7587454807644673527:2067], tenant /default
2025-12-24T15:59:46.276318Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:299: Coordinator: UpdateKnownRowDispatchers [2:7587454807644673527:2067]
2025-12-24T15:59:46.276330Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:329: Coordinator: Add new row dispatcher to map (state 1)
2025-12-24T15:59:46.278445Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/connections" actor
2025-12-24T15:59:46.278733Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/bindings" actor
2025-12-24T15:59:46.278940Z :YQ_RATE_LIMITER DEBUG: schema.cpp:71: Run create coordination node "local/RateLimiter_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/rate_limiter" actor
2025-12-24T15:59:46.278960Z :YQ_RATE_LIMITER DEBUG: schema.cpp:113: Call create coordination node "local/RateLimiter_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/rate_limiter"
2025-12-24T15:59:46.278967Z :YQ_RATE_LIMITER DEBUG: schema.cpp:411: Call create coordination node "local/RateLimiter_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/rate_limiter"
2025-12-24T15:59:46.279935Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:293: Coordinator: Successfully bootstrapped coordinator, id [2:7587454807644673617:2140], NodesManagerId [0:4705493345362661702:78], rebalancing timeout 5.000000s
2025-12-24T15:59:46.280312Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:232: TLeaderElection [2:7587454807644673618:2141] Successfully bootstrapped, local coordinator id [2:7587454807644673617:2140], tenant id default, local mode 0, coordination node path local/default, endpoint localhost:62782
2025-12-24T15:59:46.321800Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/mappings" actor
2025-12-24T15:59:46.321819Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/quotas" actor
2025-12-24T15:59:46.321919Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create directory "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc" actor
2025-12-24T15:59:46.321928Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create directory "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc"
2025-12-24T15:59:46.321942Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:383: Call create directory "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc"
2025-12-24T15:59:46.322031Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/queries" actor
2025-12-24T15:59:46.322122Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:71: Run create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/pending_small" actor
2025-12-24T15:59:46.322633Z :FQ_ROW_DISPATCHER DEBUG: row_dispatcher.cpp:637: RowDispatcher: TEvCoordinatorChangesSubscribe from [2:7587454807644673617:2140]
2025-12-24T15:59:46.322677Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:318: TNodesManagerActor::NodesHealthCheck
2025-12-24T15:59:46.323559Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:71: Run create coordination node "local/default" actor
2025-12-24T15:59:46.323580Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:113: Call create coordination node "local/default"
2025-12-24T15:59:46.323590Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:411: Call create coordination node "local/default"
2025-12-24T15:59:46.371579Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:155: Successfully created coordination node "local/default"
2025-12-24T15:59:46.371644Z :FQ_ROW_DISPATCHER DEBUG: schema.cpp:122: Reply for create coordination node "local/default": { <main>: Error: Check failed: path: '/local/default', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 7], type: EPathTypeKesus, state: EPathStateNoChanges) }
2025-12-24T15:59:46.371734Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:345: TLeaderElection [2:7587454807644673618:2141] Coordination node successfully created
2025-12-24T15:59:46.371753Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:323: TLeaderElection [2:7587454807644673618:2141] Start session
2025-12-24T15:59:46.443407Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:359: TLeaderElection [2:7587454807644673618:2141] Session successfully created
2025-12-24T15:59:46.465286Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:372: TLeaderElection [2:7587454807644673618:2141] Semaphore successfully created
2025-12-24T15:59:46.465305Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:304: TLeaderElection [2:7587454807644673618:2141] Try to acquire semaphore
2025-12-24T15:59:46.465520Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:420: TLeaderElection [2:7587454807644673618:2141] Describe semaphore
2025-12-24T15:59:46.475945Z :FQ_ROW_DISPATCHER DEBUG: leader_election.cpp:469: TLeaderElection [2:7587454807644673618:2141] Semaphore successfully described: coordinator id [1:7587454804700482369:2110] generation 4
2025-12-24T15:59:46.475977Z :FQ_ROW_DISPATCHER INFO: leader_election.cpp:471: TLeaderElection [2:7587454807644673618:2141] Send TEvCoordinatorChanged to [2:7587454807644673527:2067], new coordinator id [1:7587454804700482369:2110], previous coordinator id [0:0:0]
2025-12-24T15:59:46.476075Z :FQ_ROW_DISPATCHER DEBUG: row_dispatcher.cpp:569: RowDispatcher: Coordinator changed, old leader (empty maybe), new [1:7587454804700482369:2110] generation 4
2025-12-24T15:59:46.476164Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:440: Coordinator: New leader [1:7587454804700482369:2110], SelfId [2:7587454807644673617:2140]
2025-12-24T15:59:46.476374Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:607: RowDispatcher: TEvUndelivered, from [1:7587454804700482369:2110], reason Disconnected
2025-12-24T15:59:46.477547Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/idempotency_keys". Create session OK
2025-12-24T15:59:46.477584Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/idempotency_keys"
2025-12-24T15:59:46.477609Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/idempotency_keys"
2025-12-24T15:59:46.477680Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/result_sets". Create session OK
2025-12-24T15:59:46.477719Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/result_sets"
2025-12-24T15:59:46.477731Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/result_sets"
2025-12-24T15:59:46.478204Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/connections". Create session OK
2025-12-24T15:59:46.478227Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/connections"
2025-12-24T15:59:46.478505Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/connections"
2025-12-24T15:59:46.482677Z :YQ_RATE_LIMITER DEBUG: schema.cpp:155: Successfully created coordination node "local/RateLimiter_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/rate_limiter"
2025-12-24T15:59:46.482713Z :YQ_RATE_LIMITER DEBUG: schema.cpp:122: Reply for create coordination node "local/RateLimiter_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/rate_limiter": { <main>: Error: Check failed: path: '/local/RateLimiter_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/rate_limiter', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 56], type: EPathTypeKesus, state: EPathStateNoChanges) }
2025-12-24T15:59:46.482738Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/mappings". Create session OK
2025-12-24T15:59:46.482746Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/mappings"
2025-12-24T15:59:46.482767Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/mappings"
2025-12-24T15:59:46.483246Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/compute_databases". Create session OK
2025-12-24T15:59:46.483284Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/compute_databases"
2025-12-24T15:59:46.483291Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/compute_databases"
2025-12-24T15:59:46.483717Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/jobs". Create session OK
2025-12-24T15:59:46.483736Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/jobs"
2025-12-24T15:59:46.483748Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/jobs"
2025-12-24T15:59:46.485519Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/tenants". Create session OK
2025-12-24T15:59:46.485538Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/tenants"
2025-12-24T15:59:46.485546Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/tenants"
2025-12-24T15:59:46.489925Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/nodes". Create session OK
2025-12-24T15:59:46.489948Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/nodes"
2025-12-24T15:59:46.489952Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/nodes"
2025-12-24T15:59:46.491198Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created directory "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc"
2025-12-24T15:59:46.491263Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create directory "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc": { <main>: Error: Check failed: path: '/local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 51], type: EPathTypeDir, state: EPathStateNoChanges) }
2025-12-24T15:59:46.491319Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/queries". Create session OK
2025-12-24T15:59:46.491338Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/queries"
2025-12-24T15:59:46.491342Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/queries"
2025-12-24T15:59:46.491513Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/bindings". Create session OK
2025-12-24T15:59:46.491706Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/bindings"
2025-12-24T15:59:46.491713Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/bindings"
2025-12-24T15:59:46.498756Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/tenant_acks". Create session OK
2025-12-24T15:59:46.498772Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/tenant_acks"
2025-12-24T15:59:46.498780Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/tenant_acks"
2025-12-24T15:59:46.508851Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/quotas". Create session OK
2025-12-24T15:59:46.508877Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/quotas"
2025-12-24T15:59:46.508882Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/quotas"
2025-12-24T15:59:46.530492Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:293: Create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/pending_small". Create session OK
2025-12-24T15:59:46.530518Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:113: Call create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/pending_small"
2025-12-24T15:59:46.530524Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:354: Call create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/pending_small"
2025-12-24T15:59:46.537863Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/idempotency_keys"
2025-12-24T15:59:46.544098Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/idempotency_keys": { <main>: Error: Check failed: path: '/local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/idempotency_keys', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 64], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-12-24T15:59:46.545138Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/tenants"
2025-12-24T15:59:46.545201Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/tenants": { <main>: Error: Check failed: path: '/local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/tenants', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 52], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-12-24T15:59:46.548029Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/connections"
2025-12-24T15:59:46.548077Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/connections": { <main>: Error: Check failed: path: '/local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/connections', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 58], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-12-24T15:59:46.555902Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/compute_databases"
2025-12-24T15:59:46.556036Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/compute_databases": { <main>: Error: Check failed: path: '/local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/compute_databases', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 63], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-12-24T15:59:46.561302Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/jobs"
2025-12-24T15:59:46.561350Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/jobs": { <main>: Error: Check failed: path: '/local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/jobs', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 60], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-12-24T15:59:46.565951Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/result_sets"
2025-12-24T15:59:46.565989Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/result_sets": { <main>: Error: Check failed: path: '/local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/result_sets', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 61], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-12-24T15:59:46.569118Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/queries"
2025-12-24T15:59:46.569180Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/queries": { <main>: Error: Check failed: path: '/local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/queries', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 65], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-12-24T15:59:46.577131Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/nodes"
2025-12-24T15:59:46.577190Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/nodes": { <main>: Error: Check failed: path: '/local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/nodes', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 62], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-12-24T15:59:46.577274Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/mappings"
2025-12-24T15:59:46.577369Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/mappings": { <main>: Error: Check failed: path: '/local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/mappings', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 53], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-12-24T15:59:46.589085Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/tenant_acks"
2025-12-24T15:59:46.589143Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/tenant_acks": { <main>: Error: Check failed: path: '/local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/tenant_acks', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 57], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-12-24T15:59:46.592507Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/bindings"
2025-12-24T15:59:46.592554Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/bindings": { <main>: Error: Check failed: path: '/local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/bindings', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 59], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-12-24T15:59:46.592799Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/quotas"
2025-12-24T15:59:46.592845Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/quotas": { <main>: Error: Check failed: path: '/local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/quotas', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 67], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-12-24T15:59:46.594716Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:155: Successfully created table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/pending_small"
2025-12-24T15:59:46.594759Z :YQ_CONTROL_PLANE_STORAGE DEBUG: schema.cpp:122: Reply for create table "local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/pending_small": { <main>: Error: Check failed: path: '/local/DbPoolStorage_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/pending_small', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 66], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-12-24T15:59:46.596509Z :FQ_CONTROL_PLANE_CONFIG DEBUG: control_plane_config.cpp:190: LOADED TenantInfo: State CHANGED at 2025-12-24T15:59:41.735458Z
2025-12-24T15:59:46.670112Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:389: Send NodeInfo with size: 0 to DynamicNameserver
2025-12-24T15:59:46.823785Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-24T15:59:46.823810Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-24T15:59:47.236964Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: fe4efe5e-f6177e5c-9b4fb240-b16b6f72, Host: ghrun-4wztbyq45u, Tenant: /default
2025-12-24T15:59:47.270502Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-24T15:59:47.270522Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-24T15:59:48.237374Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: fe4efe5e-f6177e5c-9b4fb240-b16b6f73, Host: ghrun-4wztbyq45u, Tenant: /default
2025-12-24T15:59:48.278484Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7587454804700482369:2110]
2025-12-24T15:59:48.278520Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-24T15:59:48.280153Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-24T15:59:48.280185Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-24T15:59:49.238646Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: fe4efe5e-f6177e5c-9b4fb240-b16b6f74, Host: ghrun-4wztbyq45u, Tenant: /default
2025-12-24T15:59:49.267903Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-24T15:59:49.267929Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-24T15:59:49.393842Z :FQ_CONTROL_PLANE_CONFIG TRACE: control_plane_config.cpp:192: LOADED TenantInfo: State NOT changed
2025-12-24T15:59:50.239278Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: fe4efe5e-f6177e5c-9b4fb240-b16b6f75, Host: ghrun-4wztbyq45u, Tenant: /default
2025-12-24T15:59:50.266963Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-24T15:59:50.266982Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-24T15:59:50.279643Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7587454804700482369:2110]
2025-12-24T15:59:50.279734Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-24T15:59:51.239725Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: fe4efe5e-f6177e5c-9b4fb240-b16b6f76, Host: ghrun-4wztbyq45u, Tenant: /default
2025-12-24T15:59:51.268209Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-24T15:59:51.268238Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-24T15:59:51.281442Z :FQ_ROW_DISPATCHER TRACE: coordinator.cpp:665: Coordinator: Change global state to Started (by timeout)
2025-12-24T15:59:51.322667Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:318: TNodesManagerActor::NodesHealthCheck
2025-12-24T15:59:51.380102Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:389: Send NodeInfo with size: 3 to DynamicNameserver
2025-12-24T15:59:51.381214Z :INTERCONNECT WARN: interconnect_handshake.cpp:501: Handshake [2:7587454829119510126:2054] [node 1] ICH09 Neither CompatibilityInfo nor VersionTag of the peer can be validated, accepting by default
2025-12-24T15:59:51.938884Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.cpuPercent.count=0/10000 UPDATE from Peer 1
2025-12-24T15:59:52.098432Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.analyticsQuery.count=0/100 UPDATE from Peer 1
2025-12-24T15:59:52.098600Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.streamingQuery.count=0/100 UPDATE from Peer 1
2025-12-24T15:59:52.240184Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: fe4efe5e-f6177e5c-9b4fb240-b16b6f77, Host: ghrun-4wztbyq45u, Tenant: /default
2025-12-24T15:59:52.267115Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-24T15:59:52.267135Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-24T15:59:52.280097Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7587454804700482369:2110]
2025-12-24T15:59:52.280149Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-24T15:59:52.280724Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-24T15:59:52.327448Z :FQ_QUOTA_SERVICE DEBUG: quota_manager.cpp:230: IC Peers[3]: [1, 3, 4]
2025-12-24T15:59:52.338790Z :FQ_CONTROL_PLANE_CONFIG TRACE: control_plane_config.cpp:192: LOADED TenantInfo: State NOT changed
2025-12-24T15:59:53.240676Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: fe4efe5e-f6177e5c-9b4fb240-b16b6f78, Host: ghrun-4wztbyq45u, Tenant: /default
2025-12-24T15:59:53.261469Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-24T15:59:53.261533Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-24T15:59:53.813631Z :INTERCONNECT WARN: interconnect_handshake.cpp:501: Handshake [2:7587454837709444725:2055] [node 4] ICH09 Neither CompatibilityInfo nor VersionTag of the peer can be validated, accepting by default
2025-12-24T15:59:54.241095Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: fe4efe5e-f6177e5c-9b4fb240-b16b6f79, Host: ghrun-4wztbyq45u, Tenant: /default
2025-12-24T15:59:54.264940Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-24T15:59:54.264973Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-24T15:59:54.281016Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7587454804700482369:2110]
2025-12-24T15:59:54.281067Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-24T15:59:54.281715Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-24T15:59:54.547666Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.cpuPercent.count=0/10000 UPDATE from Peer 1
2025-12-24T15:59:54.558843Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.analyticsQuery.count=0/100 UPDATE from Peer 1
2025-12-24T15:59:54.559041Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.streamingQuery.count=0/100 UPDATE from Peer 1
2025-12-24T15:59:55.072949Z :INTERCONNECT WARN: interconnect_handshake.cpp:501: Handshake [2:7587454846299379324:2056] [node 3] ICH09 Neither CompatibilityInfo nor VersionTag of the peer can be validated, accepting by default
2025-12-24T15:59:55.241526Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: fe4efe5e-f6177e5c-9b4fb240-b16b6f710, Host: ghrun-4wztbyq45u, Tenant: /default
2025-12-24T15:59:55.262324Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-24T15:59:55.262352Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-24T15:59:55.338775Z :FQ_CONTROL_PLANE_CONFIG TRACE: control_plane_config.cpp:192: LOADED TenantInfo: State NOT changed
2025-12-24T15:59:55.560170Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.cpuPercent.count=0/10000 UPDATE from Peer 1
2025-12-24T15:59:55.782342Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.analyticsQuery.count=0/100 UPDATE from Peer 1
2025-12-24T15:59:55.786105Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.streamingQuery.count=1/100 UPDATE from Peer 1
2025-12-24T15:59:56.242003Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: fe4efe5e-f6177e5c-9b4fb240-b16b6f711, Host: ghrun-4wztbyq45u, Tenant: /default
2025-12-24T15:59:56.279824Z :FQ_ROW_DISPATCHER DEBUG: coordinator.cpp:599: Coordinator: Send TEvGetNodesRequest to NodesManager
2025-12-24T15:59:56.279872Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:300: Received TNodesManagerActor::TEvGetNodesRequest
2025-12-24T15:59:56.279918Z :FQ_ROW_DISPATCHER INFO: coordinator.cpp:690: Coordinator: Updated node info, node count: 4
2025-12-24T15:59:56.281871Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7587454804700482369:2110]
2025-12-24T15:59:56.281910Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-24T15:59:56.282585Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-24T15:59:56.322865Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:318: TNodesManagerActor::NodesHealthCheck
2025-12-24T15:59:56.392485Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:389: Send NodeInfo with size: 3 to DynamicNameserver
2025-12-24T15:59:56.591350Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-24T15:59:56.591371Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-24T15:59:57.242396Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: fe4efe5e-f6177e5c-9b4fb240-b16b6f712, Host: ghrun-4wztbyq45u, Tenant: /default
2025-12-24T15:59:57.265769Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-24T15:59:57.265794Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-24T15:59:58.049869Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.cpuPercent.count=0/10000 UPDATE from Peer 1
2025-12-24T15:59:58.074414Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.streamingQuery.count=1/100 UPDATE from Peer 1
2025-12-24T15:59:58.172477Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.analyticsQuery.count=0/100 UPDATE from Peer 1
2025-12-24T15:59:58.242941Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: fe4efe5e-f6177e5c-9b4fb240-b16b6f713, Host: ghrun-4wztbyq45u, Tenant: /default
2025-12-24T15:59:58.282764Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7587454804700482369:2110]
2025-12-24T15:59:58.282797Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-24T15:59:58.283405Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-24T15:59:58.327288Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-24T15:59:58.327306Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-24T15:59:58.337342Z :FQ_CONTROL_PLANE_CONFIG TRACE: control_plane_config.cpp:192: LOADED TenantInfo: State NOT changed
2025-12-24T15:59:58.462750Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:144: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Start compute actor [2:7587454859184281221:2157], task: 2
2025-12-24T15:59:58.462926Z :KQP_COMPUTE DEBUG: dq_async_compute_actor.cpp:114: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Use CPU quota: 1. Rate limiter resource: { "local/RateLimiter_e9ad457f-1b68-4b9e-ada4-71b74f7d37dc/rate_limiter", "mock_cloud/my_folder/ptqudp9cvr7clg84hf58" }
2025-12-24T15:59:58.730156Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:1064: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Received channels info: Update { Id: 1 TransportVersion: DATA_TRANSPORT_UV_PICKLE_1_0 SrcTaskId: 1 DstTaskId: 2 SrcEndpoint { ActorId { RawX1: 7587454858609965798 RawX2: 4503616807241847 } } DstEndpoint { ActorId { RawX1: 7587454859184281221 RawX2: 4503608217307245 } } WatermarksMode: WATERMARKS_MODE_DISABLED SrcStageId: 200322 DstStageId: 200339 } Update { Id: 2 TransportVersion: DATA_TRANSPORT_UV_PICKLE_1_0 SrcTaskId: 2 SrcEndpoint { ActorId { RawX1: 7587454859184281221 RawX2: 4503608217307245 } } DstEndpoint { ActorId { RawX1: 7587454858609965794 RawX2: 4503616807241843 } } WatermarksMode: WATERMARKS_MODE_DISABLED }
2025-12-24T15:59:58.730190Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:1071: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Update input channelId: 1, peer: [4:7587454858609965798:2167]
2025-12-24T15:59:58.730210Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:1083: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Update output channelId: 2, peer: [4:7587454858609965794:2163]
2025-12-24T15:59:58.889870Z :KQP_COMPUTE DEBUG: dq_compute_actor_checkpoints.cpp:197: [] Task: 2. Got TEvNewCheckpointCoordinator event: generation 1, actorId: [4:7587454858609965795:2164]
2025-12-24T15:59:58.889892Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:208: [] Task: 2. Assign checkpoint coordinator (generation = 1)
2025-12-24T15:59:58.890018Z :KQP_COMPUTE DEBUG: dq_compute_actor_checkpoints.cpp:395: [ptqudp9cvr7clg84hf58-0] Task: 2. Handle connected node 4
2025-12-24T15:59:59.243337Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: fe4efe5e-f6177e5c-9b4fb240-b16b6f714, Host: ghrun-4wztbyq45u, Tenant: /default
2025-12-24T15:59:59.266197Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-24T15:59:59.266215Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-24T15:59:59.678829Z :KQP_COMPUTE DEBUG: dq_compute_actor_impl.h:1164: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Got TEvRun from actor [4:7587454858609965795:2164]
2025-12-24T15:59:59.678951Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1483: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll inputs
2025-12-24T15:59:59.678963Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1498: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll sources
2025-12-24T15:59:59.678979Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:698: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-12-24T15:59:59.679329Z :KQP_COMPUTE TRACE: dq_compute_memory_quota.h:97: TxId: ptqudp9cvr7clg84hf58, task: 2. Peak memory usage: 2031616
2025-12-24T15:59:59.679400Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:493: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. update task runner stats
2025-12-24T15:59:59.679519Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:762: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-12-24T15:59:59.679539Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:406: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-12-24T15:59:59.679570Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:534: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:1000000;inFlightBytes:0;inFlightCount:0;)
2025-12-24T15:59:59.679588Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:1107: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Ask CPU quota: 63ms
2025-12-24T15:59:59.679670Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:605: TxId: ptqudp9cvr7clg84hf58, task: 2. no poll, channelId: 1, hasPeer: 1, finished: 0, retry: 0, lastSeqNo: 0, freeSpace: 1000000
2025-12-24T15:59:59.679894Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:129: TxId: ptqudp9cvr7clg84hf58, task: 2. Received input for channelId: 1, seqNo: 1, size: 0, chunks: 0, watermark: 0, checkpoint: 1, finished: 0, from: [4:7587454858609965799:2167], expected seqNo: 1
2025-12-24T15:59:59.679919Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:611: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. took input
2025-12-24T15:59:59.680024Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:485: [ptqudp9cvr7clg84hf58-0] Task: 2. [Checkpoint 1.1] Got checkpoint barrier from channel 1
2025-12-24T15:59:59.680085Z :DQ_TASK_RUNNER TRACE: task_runner_actor_local.cpp:356: SelfId: [2:7587454859184281223:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. No watermark 
2025-12-24T15:59:59.680103Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1483: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll inputs
2025-12-24T15:59:59.680128Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1494: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Skip polling sources because of pending checkpoint
2025-12-24T15:59:59.680135Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:698: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. DoExecuteImpl: 1
2025-12-24T15:59:59.680162Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:965: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Input data push finished. Cookie: 0 Watermark: (empty maybe) Ack: 1 TakeInputChannelDataRequests: 1
2025-12-24T15:59:59.680188Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:738: TxId: ptqudp9cvr7clg84hf58, task: 2. Sending channel data ack to channelId: 1, peer: [4:7587454858609965798:2167], from: [2:7587454859184281221:2157], freeSpace: 1000000, seqNo: 1, finished: 0
2025-12-24T15:59:59.680229Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1483: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll inputs
2025-12-24T15:59:59.680238Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1494: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Skip polling sources because of pending checkpoint
2025-12-24T15:59:59.680244Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:698: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-12-24T15:59:59.689085Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:1165: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. CPU quota delay: 9ms
2025-12-24T15:59:59.689309Z :DQ_TASK_RUNNER TRACE: task_runner_actor_local.cpp:462: SelfId: [2:7587454859184281223:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Pending 1 checkpoints to be sent
2025-12-24T15:59:59.689333Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:493: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. update task runner stats
2025-12-24T15:59:59.689448Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:762: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 1 watermark injected: (empty maybe)
2025-12-24T15:59:59.689471Z :KQP_COMPUTE DEBUG: dq_compute_actor_checkpoints.cpp:447: [ptqudp9cvr7clg84hf58-0] Task: 2. [Checkpoint 1.1] Performing task checkpoint
2025-12-24T15:59:59.689487Z :KQP_COMPUTE DEBUG: dq_async_compute_actor.cpp:816: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Save state
2025-12-24T15:59:59.689499Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:474: [ptqudp9cvr7clg84hf58-0] Task: 2. [Checkpoint 1.1] CA state saved
2025-12-24T15:59:59.689514Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:449: [ptqudp9cvr7clg84hf58-0] Task: 2. [Checkpoint 1.1] Injecting checkpoint barrier to outputs
2025-12-24T15:59:59.689539Z :KQP_COMPUTE DEBUG: dq_compute_actor_checkpoints.cpp:536: [ptqudp9cvr7clg84hf58-0] Task: 2. [Checkpoint 1.1] Task checkpoint is done. Send to storage
2025-12-24T15:59:59.689547Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:406: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-12-24T15:59:59.689568Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:534: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:1000000;inFlightBytes:0;inFlightCount:0;)
2025-12-24T15:59:59.689623Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:566: TxId: ptqudp9cvr7clg84hf58, task: 2. SendChannelData, channelId: 2, peer: [4:7587454858609965794:2163], chunks: 0, bytes: 0, watermark: 0, checkpoint: 1, seqNo: 1, finished: 0
2025-12-24T15:59:59.689644Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:460: [ptqudp9cvr7clg84hf58-0] [1:1] Got TEvSaveTaskState: task 2
2025-12-24T15:59:59.689687Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudp9cvr7clg84hf58, task: 2. no poll, channelId: 1, has inflight messages: [1], last with freeSpace: 1000000, current freeSpace: 1000000
2025-12-24T15:59:59.689721Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1483: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll inputs
2025-12-24T15:59:59.689734Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1498: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll sources
2025-12-24T15:59:59.689746Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:698: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-12-24T15:59:59.689830Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:493: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. update task runner stats
2025-12-24T15:59:59.689907Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:762: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-12-24T15:59:59.689913Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:406: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-12-24T15:59:59.689923Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:534: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:1000000;inFlightBytes:96;inFlightCount:1;)
2025-12-24T15:59:59.689945Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudp9cvr7clg84hf58, task: 2. no poll, channelId: 1, has inflight messages: [1], last with freeSpace: 1000000, current freeSpace: 1000000
2025-12-24T15:59:59.690413Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:179: TxId: ptqudp9cvr7clg84hf58, task: 2. Received channel data ack for channelId: 2, seqNo: 1, lastSentSeqNo: 1, freeSpace: 67108864, early finish: 0
2025-12-24T15:59:59.690442Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:207: TxId: ptqudp9cvr7clg84hf58, task: 2. PeerState, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;), sentSeqNo: 1, ackSeqNo: 1
2025-12-24T15:59:59.690453Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:220: TxId: ptqudp9cvr7clg84hf58, task: 2. Resume compute actor
2025-12-24T15:59:59.690465Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1483: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll inputs
2025-12-24T15:59:59.690488Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1498: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll sources
2025-12-24T15:59:59.690495Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:698: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-12-24T15:59:59.690591Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:493: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. update task runner stats
2025-12-24T15:59:59.690634Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:762: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-12-24T15:59:59.690642Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:406: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-12-24T15:59:59.690652Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:534: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;)
2025-12-24T15:59:59.690672Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudp9cvr7clg84hf58, task: 2. no poll, channelId: 1, has inflight messages: [1], last with freeSpace: 1000000, current freeSpace: 1000000
2025-12-24T15:59:59.786592Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:484: [ptqudp9cvr7clg84hf58-0] [1:1] TEvSaveTaskState Apply: task: 2
2025-12-24T15:59:59.786636Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:499: [ptqudp9cvr7clg84hf58-0] [1:1] Send TEvSaveTaskStateResult: task: 2
2025-12-24T16:00:00.093886Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.cpuPercent.count=0/10000 UPDATE from Peer 1
2025-12-24T16:00:00.116578Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.analyticsQuery.count=0/100 UPDATE from Peer 1
2025-12-24T16:00:00.116702Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.streamingQuery.count=1/100 UPDATE from Peer 1
2025-12-24T16:00:00.243771Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: fe4efe5e-f6177e5c-9b4fb240-b16b6f715, Host: ghrun-4wztbyq45u, Tenant: /default
2025-12-24T16:00:00.283653Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7587454804700482369:2110]
2025-12-24T16:00:00.283694Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-24T16:00:00.284301Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-24T16:00:00.302031Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-24T16:00:00.302049Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-24T16:00:01.244258Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: fe4efe5e-f6177e5c-9b4fb240-b16b6f716, Host: ghrun-4wztbyq45u, Tenant: /default
2025-12-24T16:00:01.265358Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-24T16:00:01.265381Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-24T16:00:01.290912Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:129: TxId: ptqudp9cvr7clg84hf58, task: 2. Received input for channelId: 1, seqNo: 2, size: 0, chunks: 0, watermark: 0, checkpoint: 1, finished: 0, from: [4:7587454858609965799:2167], expected seqNo: 2
2025-12-24T16:00:01.290938Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:611: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. took input
2025-12-24T16:00:01.290973Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:485: [ptqudp9cvr7clg84hf58-0] Task: 2. [Checkpoint 1.2] Got checkpoint barrier from channel 1
2025-12-24T16:00:01.291016Z :DQ_TASK_RUNNER TRACE: task_runner_actor_local.cpp:356: SelfId: [2:7587454859184281223:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. No watermark 
2025-12-24T16:00:01.291031Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1483: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll inputs
2025-12-24T16:00:01.291039Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1494: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Skip polling sources because of pending checkpoint
2025-12-24T16:00:01.291046Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:698: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. DoExecuteImpl: 1
2025-12-24T16:00:01.291073Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:965: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Input data push finished. Cookie: 1 Watermark: (empty maybe) Ack: 1 TakeInputChannelDataRequests: 1
2025-12-24T16:00:01.291093Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:738: TxId: ptqudp9cvr7clg84hf58, task: 2. Sending channel data ack to channelId: 1, peer: [4:7587454858609965798:2167], from: [2:7587454859184281221:2157], freeSpace: 1000000, seqNo: 2, finished: 0
2025-12-24T16:00:01.291276Z :DQ_TASK_RUNNER TRACE: task_runner_actor_local.cpp:462: SelfId: [2:7587454859184281223:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Pending 1 checkpoints to be sent
2025-12-24T16:00:01.291297Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1483: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll inputs
2025-12-24T16:00:01.291302Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1494: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Skip polling sources because of pending checkpoint
2025-12-24T16:00:01.291307Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:698: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-12-24T16:00:01.291318Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:493: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. update task runner stats
2025-12-24T16:00:01.291405Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:762: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 1 watermark injected: (empty maybe)
2025-12-24T16:00:01.291421Z :KQP_COMPUTE DEBUG: dq_compute_actor_checkpoints.cpp:447: [ptqudp9cvr7clg84hf58-0] Task: 2. [Checkpoint 1.2] Performing task checkpoint
2025-12-24T16:00:01.291428Z :KQP_COMPUTE DEBUG: dq_async_compute_actor.cpp:816: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Save state
2025-12-24T16:00:01.291438Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:474: [ptqudp9cvr7clg84hf58-0] Task: 2. [Checkpoint 1.2] CA state saved
2025-12-24T16:00:01.291447Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:449: [ptqudp9cvr7clg84hf58-0] Task: 2. [Checkpoint 1.2] Injecting checkpoint barrier to outputs
2025-12-24T16:00:01.291477Z :KQP_COMPUTE DEBUG: dq_compute_actor_checkpoints.cpp:536: [ptqudp9cvr7clg84hf58-0] Task: 2. [Checkpoint 1.2] Task checkpoint is done. Send to storage
2025-12-24T16:00:01.291486Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:406: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-12-24T16:00:01.291504Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:534: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;)
2025-12-24T16:00:01.291503Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:460: [ptqudp9cvr7clg84hf58-0] [1:2] Got TEvSaveTaskState: task 2
2025-12-24T16:00:01.291646Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:566: TxId: ptqudp9cvr7clg84hf58, task: 2. SendChannelData, channelId: 2, peer: [4:7587454858609965794:2163], chunks: 0, bytes: 0, watermark: 0, checkpoint: 1, seqNo: 2, finished: 0
2025-12-24T16:00:01.291692Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudp9cvr7clg84hf58, task: 2. no poll, channelId: 1, has inflight messages: [2], last with freeSpace: 1000000, current freeSpace: 1000000
2025-12-24T16:00:01.291716Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:493: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. update task runner stats
2025-12-24T16:00:01.291760Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:762: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-12-24T16:00:01.291766Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:406: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-12-24T16:00:01.291784Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:534: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:96;inFlightCount:1;)
2025-12-24T16:00:01.291799Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1483: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll inputs
2025-12-24T16:00:01.291806Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1498: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll sources
2025-12-24T16:00:01.291818Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:698: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-12-24T16:00:01.291938Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudp9cvr7clg84hf58, task: 2. no poll, channelId: 1, has inflight messages: [2], last with freeSpace: 1000000, current freeSpace: 1000000
2025-12-24T16:00:01.291955Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:493: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. update task runner stats
2025-12-24T16:00:01.291991Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:762: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-12-24T16:00:01.292001Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:406: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-12-24T16:00:01.292013Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:534: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:96;inFlightCount:1;)
2025-12-24T16:00:01.292052Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudp9cvr7clg84hf58, task: 2. no poll, channelId: 1, has inflight messages: [2], last with freeSpace: 1000000, current freeSpace: 1000000
2025-12-24T16:00:01.292169Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:179: TxId: ptqudp9cvr7clg84hf58, task: 2. Received channel data ack for channelId: 2, seqNo: 2, lastSentSeqNo: 2, freeSpace: 67108864, early finish: 0
2025-12-24T16:00:01.292187Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:207: TxId: ptqudp9cvr7clg84hf58, task: 2. PeerState, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;), sentSeqNo: 2, ackSeqNo: 2
2025-12-24T16:00:01.292193Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:220: TxId: ptqudp9cvr7clg84hf58, task: 2. Resume compute actor
2025-12-24T16:00:01.292214Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1483: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll inputs
2025-12-24T16:00:01.292220Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1498: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll sources
2025-12-24T16:00:01.292226Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:698: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-12-24T16:00:01.292318Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:493: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. update task runner stats
2025-12-24T16:00:01.292367Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:762: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-12-24T16:00:01.292397Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:406: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-12-24T16:00:01.292412Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:534: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;)
2025-12-24T16:00:01.292443Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudp9cvr7clg84hf58, task: 2. no poll, channelId: 1, has inflight messages: [2], last with freeSpace: 1000000, current freeSpace: 1000000
2025-12-24T16:00:01.305431Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:484: [ptqudp9cvr7clg84hf58-0] [1:2] TEvSaveTaskState Apply: task: 2
2025-12-24T16:00:01.305459Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:499: [ptqudp9cvr7clg84hf58-0] [1:2] Send TEvSaveTaskStateResult: task: 2
2025-12-24T16:00:01.323004Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:318: TNodesManagerActor::NodesHealthCheck
2025-12-24T16:00:01.369057Z :FQ_CONTROL_PLANE_CONFIG TRACE: control_plane_config.cpp:192: LOADED TenantInfo: State NOT changed
2025-12-24T16:00:01.397766Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:389: Send NodeInfo with size: 3 to DynamicNameserver
2025-12-24T16:00:02.063663Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:129: TxId: ptqudp9cvr7clg84hf58, task: 2. Received input for channelId: 1, seqNo: 3, size: 0, chunks: 0, watermark: 0, checkpoint: 1, finished: 0, from: [4:7587454858609965799:2167], expected seqNo: 3
2025-12-24T16:00:02.063685Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:611: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. took input
2025-12-24T16:00:02.063736Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:485: [ptqudp9cvr7clg84hf58-0] Task: 2. [Checkpoint 1.3] Got checkpoint barrier from channel 1
2025-12-24T16:00:02.063777Z :DQ_TASK_RUNNER TRACE: task_runner_actor_local.cpp:356: SelfId: [2:7587454859184281223:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. No watermark 
2025-12-24T16:00:02.063791Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1483: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll inputs
2025-12-24T16:00:02.063798Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1494: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Skip polling sources because of pending checkpoint
2025-12-24T16:00:02.063805Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:698: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. DoExecuteImpl: 1
2025-12-24T16:00:02.063833Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:965: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Input data push finished. Cookie: 2 Watermark: (empty maybe) Ack: 1 TakeInputChannelDataRequests: 1
2025-12-24T16:00:02.063854Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:738: TxId: ptqudp9cvr7clg84hf58, task: 2. Sending channel data ack to channelId: 1, peer: [4:7587454858609965798:2167], from: [2:7587454859184281221:2157], freeSpace: 1000000, seqNo: 3, finished: 0
2025-12-24T16:00:02.064016Z :DQ_TASK_RUNNER TRACE: task_runner_actor_local.cpp:462: SelfId: [2:7587454859184281223:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Pending 1 checkpoints to be sent
2025-12-24T16:00:02.064046Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1483: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll inputs
2025-12-24T16:00:02.064050Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1494: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Skip polling sources because of pending checkpoint
2025-12-24T16:00:02.064060Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:698: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-12-24T16:00:02.064072Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:493: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. update task runner stats
2025-12-24T16:00:02.064140Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:762: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 1 watermark injected: (empty maybe)
2025-12-24T16:00:02.064167Z :KQP_COMPUTE DEBUG: dq_compute_actor_checkpoints.cpp:447: [ptqudp9cvr7clg84hf58-0] Task: 2. [Checkpoint 1.3] Performing task checkpoint
2025-12-24T16:00:02.064176Z :KQP_COMPUTE DEBUG: dq_async_compute_actor.cpp:816: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Save state
2025-12-24T16:00:02.064186Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:474: [ptqudp9cvr7clg84hf58-0] Task: 2. [Checkpoint 1.3] CA state saved
2025-12-24T16:00:02.064193Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:449: [ptqudp9cvr7clg84hf58-0] Task: 2. [Checkpoint 1.3] Injecting checkpoint barrier to outputs
2025-12-24T16:00:02.064216Z :KQP_COMPUTE DEBUG: dq_compute_actor_checkpoints.cpp:536: [ptqudp9cvr7clg84hf58-0] Task: 2. [Checkpoint 1.3] Task checkpoint is done. Send to storage
2025-12-24T16:00:02.064222Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:406: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-12-24T16:00:02.064243Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:534: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;)
2025-12-24T16:00:02.064291Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:460: [ptqudp9cvr7clg84hf58-0] [1:3] Got TEvSaveTaskState: task 2
2025-12-24T16:00:02.064371Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:566: TxId: ptqudp9cvr7clg84hf58, task: 2. SendChannelData, channelId: 2, peer: [4:7587454858609965794:2163], chunks: 0, bytes: 0, watermark: 0, checkpoint: 1, seqNo: 3, finished: 0
2025-12-24T16:00:02.064421Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudp9cvr7clg84hf58, task: 2. no poll, channelId: 1, has inflight messages: [3], last with freeSpace: 1000000, current freeSpace: 1000000
2025-12-24T16:00:02.064433Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:493: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. update task runner stats
2025-12-24T16:00:02.064462Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:762: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-12-24T16:00:02.064468Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:406: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-12-24T16:00:02.064477Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:534: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:96;inFlightCount:1;)
2025-12-24T16:00:02.064492Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1483: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll inputs
2025-12-24T16:00:02.064498Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1498: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll sources
2025-12-24T16:00:02.064557Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:698: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-12-24T16:00:02.064682Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudp9cvr7clg84hf58, task: 2. no poll, channelId: 1, has inflight messages: [3], last with freeSpace: 1000000, current freeSpace: 1000000
2025-12-24T16:00:02.064701Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:493: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. update task runner stats
2025-12-24T16:00:02.064745Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:762: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-12-24T16:00:02.064754Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:406: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-12-24T16:00:02.064774Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:534: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:96;inFlightCount:1;)
2025-12-24T16:00:02.064808Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudp9cvr7clg84hf58, task: 2. no poll, channelId: 1, has inflight messages: [3], last with freeSpace: 1000000, current freeSpace: 1000000
2025-12-24T16:00:02.064934Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:179: TxId: ptqudp9cvr7clg84hf58, task: 2. Received channel data ack for channelId: 2, seqNo: 3, lastSentSeqNo: 3, freeSpace: 67108864, early finish: 0
2025-12-24T16:00:02.064958Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:207: TxId: ptqudp9cvr7clg84hf58, task: 2. PeerState, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;), sentSeqNo: 3, ackSeqNo: 3
2025-12-24T16:00:02.064963Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:220: TxId: ptqudp9cvr7clg84hf58, task: 2. Resume compute actor
2025-12-24T16:00:02.064990Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1483: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll inputs
2025-12-24T16:00:02.064995Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1498: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll sources
2025-12-24T16:00:02.065000Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:698: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-12-24T16:00:02.065110Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:493: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. update task runner stats
2025-12-24T16:00:02.065147Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:762: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-12-24T16:00:02.065157Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:406: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-12-24T16:00:02.065194Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:534: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;)
2025-12-24T16:00:02.065233Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudp9cvr7clg84hf58, task: 2. no poll, channelId: 1, has inflight messages: [3], last with freeSpace: 1000000, current freeSpace: 1000000
2025-12-24T16:00:02.079447Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:484: [ptqudp9cvr7clg84hf58-0] [1:3] TEvSaveTaskState Apply: task: 2
2025-12-24T16:00:02.079477Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:499: [ptqudp9cvr7clg84hf58-0] [1:3] Send TEvSaveTaskStateResult: task: 2
2025-12-24T16:00:02.244733Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: fe4efe5e-f6177e5c-9b4fb240-b16b6f717, Host: ghrun-4wztbyq45u, Tenant: /default
2025-12-24T16:00:02.284557Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7587454804700482369:2110]
2025-12-24T16:00:02.284891Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-24T16:00:02.285482Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-24T16:00:02.290339Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-24T16:00:02.290355Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-24T16:00:02.660762Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.cpuPercent.count=0/10000 UPDATE from Peer 1
2025-12-24T16:00:02.684959Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.analyticsQuery.count=0/100 UPDATE from Peer 1
2025-12-24T16:00:02.724018Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.streamingQuery.count=1/100 UPDATE from Peer 1
2025-12-24T16:00:03.045854Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:129: TxId: ptqudp9cvr7clg84hf58, task: 2. Received input for channelId: 1, seqNo: 4, size: 0, chunks: 0, watermark: 0, checkpoint: 1, finished: 0, from: [4:7587454858609965799:2167], expected seqNo: 4
2025-12-24T16:00:03.045875Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:611: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. took input
2025-12-24T16:00:03.045908Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:485: [ptqudp9cvr7clg84hf58-0] Task: 2. [Checkpoint 1.4] Got checkpoint barrier from channel 1
2025-12-24T16:00:03.045948Z :DQ_TASK_RUNNER TRACE: task_runner_actor_local.cpp:356: SelfId: [2:7587454859184281223:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. No watermark 
2025-12-24T16:00:03.045959Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1483: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll inputs
2025-12-24T16:00:03.045965Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1494: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Skip polling sources because of pending checkpoint
2025-12-24T16:00:03.045994Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:698: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. DoExecuteImpl: 1
2025-12-24T16:00:03.046018Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:965: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Input data push finished. Cookie: 3 Watermark: (empty maybe) Ack: 1 TakeInputChannelDataRequests: 1
2025-12-24T16:00:03.046032Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:738: TxId: ptqudp9cvr7clg84hf58, task: 2. Sending channel data ack to channelId: 1, peer: [4:7587454858609965798:2167], from: [2:7587454859184281221:2157], freeSpace: 1000000, seqNo: 4, finished: 0
2025-12-24T16:00:03.046213Z :DQ_TASK_RUNNER TRACE: task_runner_actor_local.cpp:462: SelfId: [2:7587454859184281223:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Pending 1 checkpoints to be sent
2025-12-24T16:00:03.046233Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1483: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll inputs
2025-12-24T16:00:03.046237Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1494: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Skip polling sources because of pending checkpoint
2025-12-24T16:00:03.046240Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:698: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-12-24T16:00:03.046248Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:493: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. update task runner stats
2025-12-24T16:00:03.046346Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:762: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 1 watermark injected: (empty maybe)
2025-12-24T16:00:03.046369Z :KQP_COMPUTE DEBUG: dq_compute_actor_checkpoints.cpp:447: [ptqudp9cvr7clg84hf58-0] Task: 2. [Checkpoint 1.4] Performing task checkpoint
2025-12-24T16:00:03.046376Z :KQP_COMPUTE DEBUG: dq_async_compute_actor.cpp:816: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Save state
2025-12-24T16:00:03.046387Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:474: [ptqudp9cvr7clg84hf58-0] Task: 2. [Checkpoint 1.4] CA state saved
2025-12-24T16:00:03.046396Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:449: [ptqudp9cvr7clg84hf58-0] Task: 2. [Checkpoint 1.4] Injecting checkpoint barrier to outputs
2025-12-24T16:00:03.046422Z :KQP_COMPUTE DEBUG: dq_compute_actor_checkpoints.cpp:536: [ptqudp9cvr7clg84hf58-0] Task: 2. [Checkpoint 1.4] Task checkpoint is done. Send to storage
2025-12-24T16:00:03.046430Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:406: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-12-24T16:00:03.046448Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:534: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;)
2025-12-24T16:00:03.046484Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:460: [ptqudp9cvr7clg84hf58-0] [1:4] Got TEvSaveTaskState: task 2
2025-12-24T16:00:03.046605Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:566: TxId: ptqudp9cvr7clg84hf58, task: 2. SendChannelData, channelId: 2, peer: [4:7587454858609965794:2163], chunks: 0, bytes: 0, watermark: 0, checkpoint: 1, seqNo: 4, finished: 0
2025-12-24T16:00:03.046653Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudp9cvr7clg84hf58, task: 2. no poll, channelId: 1, has inflight messages: [4], last with freeSpace: 1000000, current freeSpace: 1000000
2025-12-24T16:00:03.046669Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:493: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. update task runner stats
2025-12-24T16:00:03.046711Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:762: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-12-24T16:00:03.046720Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:406: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-12-24T16:00:03.046734Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:534: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:96;inFlightCount:1;)
2025-12-24T16:00:03.046751Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1483: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll inputs
2025-12-24T16:00:03.046759Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1498: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll sources
2025-12-24T16:00:03.046765Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:698: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-12-24T16:00:03.046916Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudp9cvr7clg84hf58, task: 2. no poll, channelId: 1, has inflight messages: [4], last with freeSpace: 1000000, current freeSpace: 1000000
2025-12-24T16:00:03.046935Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:493: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. update task runner stats
2025-12-24T16:00:03.046977Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:762: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-12-24T16:00:03.046990Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:406: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-12-24T16:00:03.047031Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:534: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:96;inFlightCount:1;)
2025-12-24T16:00:03.047070Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudp9cvr7clg84hf58, task: 2. no poll, channelId: 1, has inflight messages: [4], last with freeSpace: 1000000, current freeSpace: 1000000
2025-12-24T16:00:03.047100Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:179: TxId: ptqudp9cvr7clg84hf58, task: 2. Received channel data ack for channelId: 2, seqNo: 4, lastSentSeqNo: 4, freeSpace: 67108864, early finish: 0
2025-12-24T16:00:03.047121Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:207: TxId: ptqudp9cvr7clg84hf58, task: 2. PeerState, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;), sentSeqNo: 4, ackSeqNo: 4
2025-12-24T16:00:03.047127Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:220: TxId: ptqudp9cvr7clg84hf58, task: 2. Resume compute actor
2025-12-24T16:00:03.047141Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1483: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll inputs
2025-12-24T16:00:03.047147Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1498: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll sources
2025-12-24T16:00:03.047152Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:698: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-12-24T16:00:03.047300Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:493: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. update task runner stats
2025-12-24T16:00:03.047339Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:762: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-12-24T16:00:03.047347Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:406: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-12-24T16:00:03.047355Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:534: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;)
2025-12-24T16:00:03.047375Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudp9cvr7clg84hf58, task: 2. no poll, channelId: 1, has inflight messages: [4], last with freeSpace: 1000000, current freeSpace: 1000000
2025-12-24T16:00:03.060091Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:484: [ptqudp9cvr7clg84hf58-0] [1:4] TEvSaveTaskState Apply: task: 2
2025-12-24T16:00:03.060121Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:499: [ptqudp9cvr7clg84hf58-0] [1:4] Send TEvSaveTaskStateResult: task: 2
2025-12-24T16:00:03.245103Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: fe4efe5e-f6177e5c-9b4fb240-b16b6f718, Host: ghrun-4wztbyq45u, Tenant: /default
2025-12-24T16:00:03.268642Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-24T16:00:03.268679Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-24T16:00:03.583795Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:453: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Got TEvStateRequest from actor [4:7587454858609965796:2165] PingCookie: 1
2025-12-24T16:00:03.583827Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:493: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. update task runner stats
2025-12-24T16:00:04.160968Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:129: TxId: ptqudp9cvr7clg84hf58, task: 2. Received input for channelId: 1, seqNo: 5, size: 0, chunks: 0, watermark: 0, checkpoint: 1, finished: 0, from: [4:7587454858609965799:2167], expected seqNo: 5
2025-12-24T16:00:04.160991Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:611: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. took input
2025-12-24T16:00:04.161034Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:485: [ptqudp9cvr7clg84hf58-0] Task: 2. [Checkpoint 1.5] Got checkpoint barrier from channel 1
2025-12-24T16:00:04.161072Z :DQ_TASK_RUNNER TRACE: task_runner_actor_local.cpp:356: SelfId: [2:7587454859184281223:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. No watermark 
2025-12-24T16:00:04.161089Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1483: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll inputs
2025-12-24T16:00:04.161102Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1494: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Skip polling sources because of pending checkpoint
2025-12-24T16:00:04.161107Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:698: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. DoExecuteImpl: 1
2025-12-24T16:00:04.161123Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:965: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Input data push finished. Cookie: 4 Watermark: (empty maybe) Ack: 1 TakeInputChannelDataRequests: 1
2025-12-24T16:00:04.161134Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:738: TxId: ptqudp9cvr7clg84hf58, task: 2. Sending channel data ack to channelId: 1, peer: [4:7587454858609965798:2167], from: [2:7587454859184281221:2157], freeSpace: 1000000, seqNo: 5, finished: 0
2025-12-24T16:00:04.161252Z :DQ_TASK_RUNNER TRACE: task_runner_actor_local.cpp:462: SelfId: [2:7587454859184281223:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Pending 1 checkpoints to be sent
2025-12-24T16:00:04.161274Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1483: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll inputs
2025-12-24T16:00:04.161277Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1494: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Skip polling sources because of pending checkpoint
2025-12-24T16:00:04.161281Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:698: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-12-24T16:00:04.161287Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:493: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. update task runner stats
2025-12-24T16:00:04.161326Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:762: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 1 watermark injected: (empty maybe)
2025-12-24T16:00:04.161335Z :KQP_COMPUTE DEBUG: dq_compute_actor_checkpoints.cpp:447: [ptqudp9cvr7clg84hf58-0] Task: 2. [Checkpoint 1.5] Performing task checkpoint
2025-12-24T16:00:04.161339Z :KQP_COMPUTE DEBUG: dq_async_compute_actor.cpp:816: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Save state
2025-12-24T16:00:04.161345Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:474: [ptqudp9cvr7clg84hf58-0] Task: 2. [Checkpoint 1.5] CA state saved
2025-12-24T16:00:04.161352Z :KQP_COMPUTE TRACE: dq_compute_actor_checkpoints.cpp:449: [ptqudp9cvr7clg84hf58-0] Task: 2. [Checkpoint 1.5] Injecting checkpoint barrier to outputs
2025-12-24T16:00:04.161370Z :KQP_COMPUTE DEBUG: dq_compute_actor_checkpoints.cpp:536: [ptqudp9cvr7clg84hf58-0] Task: 2. [Checkpoint 1.5] Task checkpoint is done. Send to storage
2025-12-24T16:00:04.161375Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:406: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-12-24T16:00:04.161391Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:534: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;)
2025-12-24T16:00:04.161413Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:460: [ptqudp9cvr7clg84hf58-0] [1:5] Got TEvSaveTaskState: task 2
2025-12-24T16:00:04.161507Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:566: TxId: ptqudp9cvr7clg84hf58, task: 2. SendChannelData, channelId: 2, peer: [4:7587454858609965794:2163], chunks: 0, bytes: 0, watermark: 0, checkpoint: 1, seqNo: 5, finished: 0
2025-12-24T16:00:04.161548Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudp9cvr7clg84hf58, task: 2. no poll, channelId: 1, has inflight messages: [5], last with freeSpace: 1000000, current freeSpace: 1000000
2025-12-24T16:00:04.161575Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:493: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. update task runner stats
2025-12-24T16:00:04.161618Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:762: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-12-24T16:00:04.161625Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:406: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-12-24T16:00:04.161643Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:534: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:96;inFlightCount:1;)
2025-12-24T16:00:04.161660Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1483: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll inputs
2025-12-24T16:00:04.161665Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1498: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll sources
2025-12-24T16:00:04.161670Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:698: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-12-24T16:00:04.161777Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudp9cvr7clg84hf58, task: 2. no poll, channelId: 1, has inflight messages: [5], last with freeSpace: 1000000, current freeSpace: 1000000
2025-12-24T16:00:04.161788Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:493: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. update task runner stats
2025-12-24T16:00:04.161857Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:762: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-12-24T16:00:04.161880Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:406: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-12-24T16:00:04.161892Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:534: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:96;inFlightCount:1;)
2025-12-24T16:00:04.161919Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudp9cvr7clg84hf58, task: 2. no poll, channelId: 1, has inflight messages: [5], last with freeSpace: 1000000, current freeSpace: 1000000
2025-12-24T16:00:04.162207Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:179: TxId: ptqudp9cvr7clg84hf58, task: 2. Received channel data ack for channelId: 2, seqNo: 5, lastSentSeqNo: 5, freeSpace: 67108864, early finish: 0
2025-12-24T16:00:04.162226Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:207: TxId: ptqudp9cvr7clg84hf58, task: 2. PeerState, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;), sentSeqNo: 5, ackSeqNo: 5
2025-12-24T16:00:04.162230Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:220: TxId: ptqudp9cvr7clg84hf58, task: 2. Resume compute actor
2025-12-24T16:00:04.162240Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1483: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll inputs
2025-12-24T16:00:04.162243Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:1498: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Poll sources
2025-12-24T16:00:04.162246Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:698: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-12-24T16:00:04.162323Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:493: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. update task runner stats
2025-12-24T16:00:04.162347Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:762: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: (empty maybe)
2025-12-24T16:00:04.162350Z :KQP_COMPUTE TRACE: dq_compute_actor_impl.h:406: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-12-24T16:00:04.162357Z :KQP_COMPUTE TRACE: dq_async_compute_actor.cpp:534: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;)
2025-12-24T16:00:04.162373Z :KQP_COMPUTE TRACE: dq_compute_actor_channels.cpp:625: TxId: ptqudp9cvr7clg84hf58, task: 2. no poll, channelId: 1, has inflight messages: [5], last with freeSpace: 1000000, current freeSpace: 1000000
2025-12-24T16:00:04.175013Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:484: [ptqudp9cvr7clg84hf58-0] [1:5] TEvSaveTaskState Apply: task: 2
2025-12-24T16:00:04.175039Z :STREAMS_STORAGE_SERVICE DEBUG: storage_proxy.cpp:499: [ptqudp9cvr7clg84hf58-0] [1:5] Send TEvSaveTaskStateResult: task: 2
2025-12-24T16:00:04.192213Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.cpuPercent.count=0/10000 UPDATE from Peer 1
2025-12-24T16:00:04.213237Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.streamingQuery.count=1/100 UPDATE from Peer 1
2025-12-24T16:00:04.213474Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.analyticsQuery.count=0/100 UPDATE from Peer 1
2025-12-24T16:00:04.245529Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: fe4efe5e-f6177e5c-9b4fb240-b16b6f719, Host: ghrun-4wztbyq45u, Tenant: /default
2025-12-24T16:00:04.266554Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-24T16:00:04.266577Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-24T16:00:04.285446Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7587454804700482369:2110]
2025-12-24T16:00:04.285484Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-24T16:00:04.286119Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:633: RowDispatcher: NActors::TEvents::TEvPong
2025-12-24T16:00:04.340664Z :FQ_CONTROL_PLANE_CONFIG TRACE: control_plane_config.cpp:192: LOADED TenantInfo: State NOT changed
2025-12-24T16:00:04.537543Z :KQP_COMPUTE ERROR: dq_compute_actor_impl.h:1205: SelfId: [2:7587454859184281221:2157], TxId: ptqudp9cvr7clg84hf58, task: 2. Ctx: {}. Handle abort execution event from: [2:7587454807644673528:2068], status: UNAVAILABLE, reason: { <main>: Error: Aborted by LWM }
2025-12-24T16:00:04.537702Z :KQP_COMPUTE DEBUG: dq_compute_actor_channels.cpp:494: TxId: ptqudp9cvr7clg84hf58, task: 2. pass away
2025-12-24T16:00:05.246308Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: fe4efe5e-f6177e5c-9b4fb240-b16b6f720, Host: ghrun-4wztbyq45u, Tenant: /default
2025-12-24T16:00:05.278241Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-24T16:00:05.278261Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-24T16:00:06.246492Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:329: Request Private::GetTask, Owner: fe4efe5e-f6177e5c-9b4fb240-b16b6f721, Host: ghrun-4wztbyq45u, Tenant: /default
2025-12-24T16:00:06.282033Z :FQ_QUOTA_SERVICE TRACE: quota_manager.cpp:505: cloud.mock_cloud.yq.cpuPercent.count=0/10000 UPDATE from Peer 1
2025-12-24T16:00:06.286213Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:254: Got GetTask response from PrivateApi
2025-12-24T16:00:06.286235Z :FQ_PENDING_FETCHER TRACE: pending_fetcher.cpp:266: Tasks count: 0
2025-12-24T16:00:06.286407Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:627: RowDispatcher: Send ping to [1:7587454804700482369:2110]
2025-12-24T16:00:06.286431Z :FQ_ROW_DISPATCHER TRACE: row_dispatcher.cpp:1174: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-12-24T16:00:06.325433Z :YQL_NODES_MANAGER TRACE: nodes_manager.cpp:318: TNodesManagerActor::NodesHealthCheck
