2025-11-05T14:20:55.034813Z :FQ_CONTROL_PLANE_CONFIG DEBUG: STARTING: [2:7569246161046300228:2061]
2025-11-05T14:20:55.096814Z :YQ_CONTROL_PLANE_PROXY DEBUG: Starting yandex query control plane proxy. Actor id: [2:7569246161046300229:2062]
2025-11-05T14:20:55.102168Z :YQ_RATE_LIMITER INFO: Bootstraping with config: { Enabled: true ControlPlaneEnabled: true DataPlaneEnabled: true Database { Endpoint: "localhost:17369" Database: "local" TablePrefix: "RateLimiter_7d4bd615-c9f2-42e3-97d6-4f512c27ed00" } Limiters { CoordinationNodePath: "rate_limiter" } }
2025-11-05T14:20:55.171092Z :MEMORY_PROFILER NOTICE: Bootstrapped
2025-11-05T14:20:55.229452Z :YQ_RATE_LIMITER DEBUG: Run create coordination node "local/RateLimiter_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/rate_limiter" actor
2025-11-05T14:20:55.229468Z :YQ_RATE_LIMITER DEBUG: Call create coordination node "local/RateLimiter_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/rate_limiter"
2025-11-05T14:20:55.229480Z :YQ_RATE_LIMITER DEBUG: Call create coordination node "local/RateLimiter_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/rate_limiter"
2025-11-05T14:20:55.229675Z :FQ_ROW_DISPATCHER DEBUG: RowDispatcher: Successfully bootstrapped row dispatcher, id [2:7569246161046300234:2067], tenant /default
2025-11-05T14:20:55.230570Z :YQL_NODES_MANAGER INFO: Bootstrap, InstanceId: 61a54aa4-43c811db-8920319a-29a0c6bb
2025-11-05T14:20:55.230579Z :YQL_NODES_MANAGER DEBUG: TNodesManagerActor::ResolveSelfAddress
2025-11-05T14:20:55.230885Z :FQ_ROW_DISPATCHER DEBUG: Coordinator: Successfully bootstrapped coordinator, id [2:7569246161046300300:2118]
2025-11-05T14:20:55.253226Z :YQ_TEST_CONNECTION DEBUG: Starting yandex query test connection. Actor id: [2:7569246161046300239:2072]
2025-11-05T14:20:55.253389Z :FQ_ROW_DISPATCHER DEBUG: TLeaderElection [2:7569246161046300301:2119] Successfully bootstrapped, local coordinator id [2:7569246161046300300:2118]
2025-11-05T14:20:55.603056Z :FQ_PENDING_FETCHER TRACE: Request Private::GetTask, Owner: 3fc00d23-eb88c9ec-a5f5de45-b37062941, Host: ghrun-uqiopzyque, Tenant: /default
2025-11-05T14:20:55.603135Z :GRPC_SERVER NOTICE: Grpc simple request proxy started, nodeid# 2
2025-11-05T14:20:55.603529Z :GRPC_SERVER NOTICE: Grpc simple request proxy started, nodeid# 2
2025-11-05T14:20:55.603660Z :FQ_LOG_UPDATER DEBUG: Updated YQL logs priority: 8
2025-11-05T14:20:55.603694Z :FQ_LOG_UPDATER CRIT: Failed to deliver subscription request to config dispatcher.
2025-11-05T14:20:55.603984Z :FQ_QUOTA_SERVICE INFO: STARTED
2025-11-05T14:20:55.604557Z :YQ_CONTROL_PLANE_STORAGE INFO: Starting ydb control plane storage service. Actor id: [2:7569246161046300227:2060]
2025-11-05T14:20:55.606802Z :FQ_QUOTA_PROXY INFO: STARTED
2025-11-05T14:20:55.607109Z :FQ_ROW_DISPATCHER DEBUG: Run create coordination node "local/row_dispatcher//default" actor
2025-11-05T14:20:55.607138Z :FQ_ROW_DISPATCHER DEBUG: Call create coordination node "local/row_dispatcher//default"
2025-11-05T14:20:55.607153Z :FQ_ROW_DISPATCHER DEBUG: Call create coordination node "local/row_dispatcher//default"
2025-11-05T14:20:55.607267Z :YQL_NODES_MANAGER TRACE: TNodesManagerActor::NodesHealthCheck
2025-11-05T14:20:55.607670Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Run create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/quotas" actor
2025-11-05T14:20:55.607855Z :FQ_ROW_DISPATCHER DEBUG: RowDispatcher: TEvCoordinatorChangesSubscribe from [2:7569246161046300300:2118]
2025-11-05T14:20:55.607899Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Run create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/mappings" actor
2025-11-05T14:20:55.607970Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Run create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/compute_databases" actor
2025-11-05T14:20:55.608310Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Run create directory "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00" actor
2025-11-05T14:20:55.608320Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create directory "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00"
2025-11-05T14:20:55.608334Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create directory "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00"
2025-11-05T14:20:55.608449Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Run create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/pending_small" actor
2025-11-05T14:20:55.608708Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Run create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/connections" actor
2025-11-05T14:20:55.608775Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Run create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/bindings" actor
2025-11-05T14:20:55.608825Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Run create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/idempotency_keys" actor
2025-11-05T14:20:55.608896Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Run create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/result_sets" actor
2025-11-05T14:20:55.608964Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Run create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/jobs" actor
2025-11-05T14:20:55.609006Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Run create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/nodes" actor
2025-11-05T14:20:55.609061Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Run create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/tenant_acks" actor
2025-11-05T14:20:55.609102Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Run create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/queries" actor
2025-11-05T14:20:55.609780Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Run create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/tenants" actor
2025-11-05T14:20:56.133306Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/compute_databases". Create session OK
2025-11-05T14:20:56.133342Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/compute_databases"
2025-11-05T14:20:56.133353Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/compute_databases"
2025-11-05T14:20:56.208806Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/bindings". Create session OK
2025-11-05T14:20:56.208839Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/bindings"
2025-11-05T14:20:56.208846Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/bindings"
2025-11-05T14:20:56.287560Z :FQ_PENDING_FETCHER TRACE: Got GetTask response from PrivateApi
2025-11-05T14:20:56.287632Z :FQ_PENDING_FETCHER ERROR: Error with GetTask: <main>: Error: Control Plane is not ready yet. Please retry later., code: 1007
<main>: Error: ControlPlane::GetTaskError

2025-11-05T14:20:56.305402Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/connections". Create session OK
2025-11-05T14:20:56.305440Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/connections"
2025-11-05T14:20:56.305460Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/connections"
2025-11-05T14:20:56.542130Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/tenant_acks". Create session OK
2025-11-05T14:20:56.542161Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/tenant_acks"
2025-11-05T14:20:56.542179Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/tenant_acks"
2025-11-05T14:20:56.554040Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/jobs". Create session OK
2025-11-05T14:20:56.554069Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/jobs"
2025-11-05T14:20:56.554076Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/jobs"
2025-11-05T14:20:56.593719Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/result_sets". Create session OK
2025-11-05T14:20:56.593752Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/result_sets"
2025-11-05T14:20:56.593763Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/result_sets"
2025-11-05T14:20:56.594653Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/idempotency_keys". Create session OK
2025-11-05T14:20:56.594680Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/idempotency_keys"
2025-11-05T14:20:56.594696Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/idempotency_keys"
2025-11-05T14:20:56.603376Z :FQ_PENDING_FETCHER TRACE: Request Private::GetTask, Owner: 3fc00d23-eb88c9ec-a5f5de45-b37062942, Host: ghrun-uqiopzyque, Tenant: /default
2025-11-05T14:20:56.610357Z :FQ_PENDING_FETCHER TRACE: Got GetTask response from PrivateApi
2025-11-05T14:20:56.610422Z :FQ_PENDING_FETCHER ERROR: Error with GetTask: <main>: Error: Control Plane is not ready yet. Please retry later., code: 1007
<main>: Error: ControlPlane::GetTaskError

2025-11-05T14:20:56.797996Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/pending_small". Create session OK
2025-11-05T14:20:56.798028Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/pending_small"
2025-11-05T14:20:56.798043Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/pending_small"
2025-11-05T14:20:56.803288Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/quotas". Create session OK
2025-11-05T14:20:56.803310Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/quotas"
2025-11-05T14:20:56.803331Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/quotas"
2025-11-05T14:20:56.804281Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/tenants". Create session OK
2025-11-05T14:20:56.804338Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/tenants"
2025-11-05T14:20:56.804347Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/tenants"
2025-11-05T14:20:56.810041Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/nodes". Create session OK
2025-11-05T14:20:56.810091Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/nodes"
2025-11-05T14:20:56.810098Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/nodes"
2025-11-05T14:20:56.842652Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/queries". Create session OK
2025-11-05T14:20:56.842694Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/queries"
2025-11-05T14:20:56.842703Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/queries"
2025-11-05T14:20:57.030720Z :YQ_RATE_LIMITER DEBUG: Successfully created coordination node "local/RateLimiter_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/rate_limiter"
2025-11-05T14:20:57.030794Z :YQ_RATE_LIMITER DEBUG: Reply for create coordination node "local/RateLimiter_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/rate_limiter": { <main>: Error: Check failed: path: '/local/RateLimiter_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/rate_limiter', error: path exist, request accepts it (id: [OwnerId: 72075186232723360, LocalPathId: 7], type: EPathTypeKesus, state: EPathStateNoChanges) }
2025-11-05T14:20:57.033165Z :FQ_ROW_DISPATCHER DEBUG: Successfully created coordination node "local/row_dispatcher//default"
2025-11-05T14:20:57.033219Z :FQ_ROW_DISPATCHER DEBUG: Reply for create coordination node "local/row_dispatcher//default": { <main>: Error: Check failed: path: '/local/row_dispatcher/default', error: path exist, request accepts it (id: [OwnerId: 72075186232723360, LocalPathId: 11], type: EPathTypeKesus, state: EPathStateNoChanges) }
2025-11-05T14:20:57.033284Z :FQ_ROW_DISPATCHER DEBUG: TLeaderElection [2:7569246161046300301:2119] Coordination node successfully created
2025-11-05T14:20:57.033299Z :FQ_ROW_DISPATCHER DEBUG: TLeaderElection [2:7569246161046300301:2119] Start session
2025-11-05T14:20:57.097999Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Successfully created directory "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00"
2025-11-05T14:20:57.098087Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Reply for create directory "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00": { <main>: Error: Check failed: path: '/local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00', error: path exist, request accepts it (id: [OwnerId: 72075186232723360, LocalPathId: 2], type: EPathTypeDir, state: EPathStateNoChanges) }
2025-11-05T14:20:57.098746Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/mappings". Create session OK
2025-11-05T14:20:57.098770Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/mappings"
2025-11-05T14:20:57.098777Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/mappings"
2025-11-05T14:20:57.237220Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-11-05T14:20:57.284439Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Successfully created table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/connections"
2025-11-05T14:20:57.284498Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Reply for create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/connections": { <main>: Error: Check failed: path: '/local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/connections', error: path exist, request accepts it (id: [OwnerId: 72075186232723360, LocalPathId: 13], type: EPathTypeTable, state: EPathStateCreate) }
2025-11-05T14:20:57.292012Z :FQ_ROW_DISPATCHER DEBUG: TLeaderElection [2:7569246161046300301:2119] Session successfully created
2025-11-05T14:20:57.292365Z :YQ_CONTROL_PLANE_STORAGE ERROR: Create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/bindings" error: OVERLOADED { <main>: Error: Check failed: path: '/local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/bindings', error: path exists but creating right now (id: [OwnerId: 72075186232723360, LocalPathId: 19], type: EPathTypeTable, state: EPathStateCreate) }
2025-11-05T14:20:57.366525Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Successfully created table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/compute_databases"
2025-11-05T14:20:57.366585Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Reply for create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/compute_databases": { <main>: Error: Check failed: path: '/local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/compute_databases', error: path exist, request accepts it (id: [OwnerId: 72075186232723360, LocalPathId: 15], type: EPathTypeTable, state: EPathStateCreate) }
2025-11-05T14:20:57.404957Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Successfully created table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/tenant_acks"
2025-11-05T14:20:57.405025Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Reply for create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/tenant_acks": { <main>: Error: Check failed: path: '/local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/tenant_acks', error: path exist, request accepts it (id: [OwnerId: 72075186232723360, LocalPathId: 12], type: EPathTypeTable, state: EPathStateCreate) }
2025-11-05T14:20:57.432965Z :YQ_CONTROL_PLANE_STORAGE ERROR: Create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/jobs" error: OVERLOADED { <main>: Error: Check failed: path: '/local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/jobs', error: path exists but creating right now (id: [OwnerId: 72075186232723360, LocalPathId: 18], type: EPathTypeTable, state: EPathStateCreate) }
2025-11-05T14:20:57.438140Z :YQ_CONTROL_PLANE_STORAGE ERROR: Create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/idempotency_keys" error: OVERLOADED { <main>: Error: Check failed: path: '/local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/idempotency_keys', error: path exists but creating right now (id: [OwnerId: 72075186232723360, LocalPathId: 22], type: EPathTypeTable, state: EPathStateCreate) }
2025-11-05T14:20:57.448952Z :YQ_CONTROL_PLANE_STORAGE ERROR: Create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/nodes" error: OVERLOADED { <main>: Error: Check failed: path: '/local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/nodes', error: path exists but creating right now (id: [OwnerId: 72075186232723360, LocalPathId: 21], type: EPathTypeTable, state: EPathStateCreate) }
2025-11-05T14:20:57.490539Z :FQ_CONTROL_PLANE_CONFIG DEBUG: LOADED TenantInfo: State CHANGED at 2025-11-05T14:20:49.102995Z
2025-11-05T14:20:57.549331Z :FQ_ROW_DISPATCHER DEBUG: TLeaderElection [2:7569246161046300301:2119] Semaphore successfully created
2025-11-05T14:20:57.549370Z :FQ_ROW_DISPATCHER DEBUG: TLeaderElection [2:7569246161046300301:2119] Try to acquire semaphore
2025-11-05T14:20:57.549664Z :FQ_ROW_DISPATCHER DEBUG: TLeaderElection [2:7569246161046300301:2119] Describe semaphore
2025-11-05T14:20:57.608814Z :FQ_PENDING_FETCHER TRACE: Request Private::GetTask, Owner: 3fc00d23-eb88c9ec-a5f5de45-b37062943, Host: ghrun-uqiopzyque, Tenant: /default
2025-11-05T14:20:57.690487Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Successfully created table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/result_sets"
2025-11-05T14:20:57.690550Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Reply for create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/result_sets": { <main>: Error: Check failed: path: '/local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/result_sets', error: path exist, request accepts it (id: [OwnerId: 72075186232723360, LocalPathId: 16], type: EPathTypeTable, state: EPathStateCreate) }
2025-11-05T14:20:57.692758Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Successfully created table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/mappings"
2025-11-05T14:20:57.692821Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Reply for create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/mappings": { <main>: Error: Check failed: path: '/local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/mappings', error: path exist, request accepts it (id: [OwnerId: 72075186232723360, LocalPathId: 4], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-11-05T14:20:57.693829Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Successfully created table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/pending_small"
2025-11-05T14:20:57.693872Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Reply for create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/pending_small": { <main>: Error: Check failed: path: '/local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/pending_small', error: path exist, request accepts it (id: [OwnerId: 72075186232723360, LocalPathId: 14], type: EPathTypeTable, state: EPathStateCreate) }
2025-11-05T14:20:57.694043Z :YQ_CONTROL_PLANE_STORAGE ERROR: Create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/queries" error: OVERLOADED { <main>: Error: Check failed: path: '/local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/queries', error: path exists but creating right now (id: [OwnerId: 72075186232723360, LocalPathId: 20], type: EPathTypeTable, state: EPathStateCreate) }
2025-11-05T14:20:57.694089Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Successfully created table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/tenants"
2025-11-05T14:20:57.694114Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Reply for create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/tenants": { <main>: Error: Check failed: path: '/local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/tenants', error: path exist, request accepts it (id: [OwnerId: 72075186232723360, LocalPathId: 3], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-11-05T14:20:57.695028Z :YQ_CONTROL_PLANE_STORAGE ERROR: Create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/quotas" error: OVERLOADED { <main>: Error: Check failed: path: '/local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/quotas', error: path exists but creating right now (id: [OwnerId: 72075186232723360, LocalPathId: 23], type: EPathTypeTable, state: EPathStateCreate) }
2025-11-05T14:20:57.765096Z :FQ_ROW_DISPATCHER DEBUG: TLeaderElection [2:7569246161046300301:2119] Semaphore successfully described: coordinator id [3:7569246154914269600:2118] generation 1
2025-11-05T14:20:57.765134Z :FQ_ROW_DISPATCHER INFO: TLeaderElection [2:7569246161046300301:2119] Send TEvCoordinatorChanged to [2:7569246161046300234:2067]
2025-11-05T14:20:57.765188Z :FQ_ROW_DISPATCHER DEBUG: RowDispatcher: Coordinator changed, old leader (empty maybe), new [3:7569246154914269600:2118] generation 1
2025-11-05T14:20:57.765278Z :FQ_ROW_DISPATCHER DEBUG: Coordinator: New leader [3:7569246154914269600:2118], SelfId [2:7569246161046300300:2118]
2025-11-05T14:20:57.767631Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: TEvUndelivered, from [3:7569246154914269600:2118], reason Disconnected
2025-11-05T14:20:57.878279Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/bindings"
2025-11-05T14:20:57.878304Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/bindings"
2025-11-05T14:20:58.212887Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/quotas"
2025-11-05T14:20:58.212905Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/quotas"
2025-11-05T14:20:58.294979Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Successfully created table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/bindings"
2025-11-05T14:20:58.295033Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Reply for create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/bindings": { <main>: Error: Check failed: path: '/local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/bindings', error: path exist, request accepts it (id: [OwnerId: 72075186232723360, LocalPathId: 19], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-11-05T14:20:58.305317Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/nodes"
2025-11-05T14:20:58.305334Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/nodes"
2025-11-05T14:20:58.319245Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/jobs"
2025-11-05T14:20:58.319268Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/jobs"
2025-11-05T14:20:58.348982Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/idempotency_keys"
2025-11-05T14:20:58.349184Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/idempotency_keys"
2025-11-05T14:20:58.437024Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Successfully created table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/quotas"
2025-11-05T14:20:58.437078Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Reply for create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/quotas": { <main>: Error: Check failed: path: '/local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/quotas', error: path exist, request accepts it (id: [OwnerId: 72075186232723360, LocalPathId: 23], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-11-05T14:20:58.462340Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Successfully created table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/jobs"
2025-11-05T14:20:58.462391Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Reply for create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/jobs": { <main>: Error: Check failed: path: '/local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/jobs', error: path exist, request accepts it (id: [OwnerId: 72075186232723360, LocalPathId: 18], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-11-05T14:20:58.464937Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Successfully created table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/nodes"
2025-11-05T14:20:58.465000Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Reply for create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/nodes": { <main>: Error: Check failed: path: '/local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/nodes', error: path exist, request accepts it (id: [OwnerId: 72075186232723360, LocalPathId: 21], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-11-05T14:20:58.477684Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Successfully created table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/idempotency_keys"
2025-11-05T14:20:58.477769Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Reply for create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/idempotency_keys": { <main>: Error: Check failed: path: '/local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/idempotency_keys', error: path exist, request accepts it (id: [OwnerId: 72075186232723360, LocalPathId: 22], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-11-05T14:20:58.517463Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/queries"
2025-11-05T14:20:58.517491Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Call create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/queries"
2025-11-05T14:20:58.566202Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Successfully created table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/queries"
2025-11-05T14:20:58.566276Z :YQ_CONTROL_PLANE_STORAGE DEBUG: Reply for create table "local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/queries": { <main>: Error: Check failed: path: '/local/DbPoolStorage_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/queries', error: path exist, request accepts it (id: [OwnerId: 72075186232723360, LocalPathId: 20], type: EPathTypeTable, state: EPathStateNoChanges) }
2025-11-05T14:20:58.708476Z :FQ_CONTROL_PLANE_CONFIG TRACE: LOADED TenantInfo: State NOT changed
2025-11-05T14:20:59.021468Z :FQ_PENDING_FETCHER TRACE: Got GetTask response from PrivateApi
2025-11-05T14:20:59.021500Z :FQ_PENDING_FETCHER TRACE: Tasks count: 0
2025-11-05T14:20:59.237213Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: Send ping to [3:7569246154914269600:2118]
2025-11-05T14:20:59.240838Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-11-05T14:20:59.336346Z :YQL_NODES_MANAGER TRACE: Send NodeInfo with size: 1 to DynamicNameserver
2025-11-05T14:20:59.608767Z :FQ_PENDING_FETCHER TRACE: Request Private::GetTask, Owner: 3fc00d23-eb88c9ec-a5f5de45-b37062944, Host: ghrun-uqiopzyque, Tenant: /default
2025-11-05T14:20:59.612796Z :FQ_QUOTA_SERVICE DEBUG: IC Peers[1]: [1]
2025-11-05T14:20:59.641199Z :FQ_PENDING_FETCHER TRACE: Got GetTask response from PrivateApi
2025-11-05T14:20:59.641232Z :FQ_PENDING_FETCHER TRACE: Tasks count: 0
2025-11-05T14:21:00.093009Z :STREAMS_STORAGE_SERVICE INFO: Successfully bootstrapped TStorageProxy [2:7569246161046300233:2066] with connection to localhost:17369:local
2025-11-05T14:21:00.604459Z :YQL_NODES_MANAGER TRACE: TNodesManagerActor::NodesHealthCheck
2025-11-05T14:21:00.610381Z :FQ_PENDING_FETCHER TRACE: Request Private::GetTask, Owner: 3fc00d23-eb88c9ec-a5f5de45-b37062945, Host: ghrun-uqiopzyque, Tenant: /default
2025-11-05T14:21:00.641819Z :FQ_PENDING_FETCHER TRACE: Got GetTask response from PrivateApi
2025-11-05T14:21:00.641847Z :FQ_PENDING_FETCHER TRACE: Tasks count: 0
2025-11-05T14:21:00.668281Z :YQL_NODES_MANAGER TRACE: Send NodeInfo with size: 3 to DynamicNameserver
2025-11-05T14:21:01.239152Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: Send ping to [3:7569246154914269600:2118]
2025-11-05T14:21:01.252180Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-11-05T14:21:01.276365Z :INTERCONNECT WARN: Handshake [2:7569246186816104116:2052] [node 3] ICH09 Neither CompatibilityInfo nor VersionTag of the peer can be validated, accepting by default
2025-11-05T14:21:01.341358Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: NActors::TEvents::TEvPong
2025-11-05T14:21:01.613139Z :FQ_PENDING_FETCHER TRACE: Request Private::GetTask, Owner: 3fc00d23-eb88c9ec-a5f5de45-b37062946, Host: ghrun-uqiopzyque, Tenant: /default
2025-11-05T14:21:01.629375Z :FQ_CONTROL_PLANE_CONFIG TRACE: LOADED TenantInfo: State NOT changed
2025-11-05T14:21:01.648654Z :FQ_PENDING_FETCHER TRACE: Got GetTask response from PrivateApi
2025-11-05T14:21:01.648688Z :FQ_PENDING_FETCHER TRACE: Tasks count: 0
2025-11-05T14:21:02.613542Z :FQ_PENDING_FETCHER TRACE: Request Private::GetTask, Owner: 3fc00d23-eb88c9ec-a5f5de45-b37062947, Host: ghrun-uqiopzyque, Tenant: /default
2025-11-05T14:21:02.666417Z :FQ_PENDING_FETCHER TRACE: Got GetTask response from PrivateApi
2025-11-05T14:21:02.666441Z :FQ_PENDING_FETCHER TRACE: Tasks count: 0
2025-11-05T14:21:03.238102Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: Send ping to [3:7569246154914269600:2118]
2025-11-05T14:21:03.242500Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: NActors::TEvents::TEvPong
2025-11-05T14:21:03.250216Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-11-05T14:21:03.446196Z :INTERCONNECT WARN: Handshake [2:7569246195406038714:2054] [node 1] ICH09 Neither CompatibilityInfo nor VersionTag of the peer can be validated, accepting by default
2025-11-05T14:21:03.457409Z :FQ_QUOTA_SERVICE TRACE: cloud.mock_cloud.yq.cpuPercent.count=0/10000 UPDATE from Peer 1
2025-11-05T14:21:03.616874Z :FQ_PENDING_FETCHER TRACE: Request Private::GetTask, Owner: 3fc00d23-eb88c9ec-a5f5de45-b37062948, Host: ghrun-uqiopzyque, Tenant: /default
2025-11-05T14:21:03.661034Z :FQ_PENDING_FETCHER TRACE: Got GetTask response from PrivateApi
2025-11-05T14:21:03.661063Z :FQ_PENDING_FETCHER TRACE: Tasks count: 0
2025-11-05T14:21:03.701115Z :FQ_QUOTA_SERVICE TRACE: cloud.mock_cloud.yq.analyticsQuery.count=0/100 UPDATE from Peer 1
2025-11-05T14:21:03.709209Z :FQ_QUOTA_SERVICE TRACE: cloud.mock_cloud.yq.streamingQuery.count=0/100 UPDATE from Peer 1
2025-11-05T14:21:04.612878Z :FQ_QUOTA_SERVICE DEBUG: IC Peers[3]: [1, 3, 4]
2025-11-05T14:21:04.618762Z :FQ_PENDING_FETCHER TRACE: Request Private::GetTask, Owner: 3fc00d23-eb88c9ec-a5f5de45-b37062949, Host: ghrun-uqiopzyque, Tenant: /default
2025-11-05T14:21:04.645376Z :FQ_CONTROL_PLANE_CONFIG TRACE: LOADED TenantInfo: State NOT changed
2025-11-05T14:21:04.652762Z :FQ_PENDING_FETCHER TRACE: Got GetTask response from PrivateApi
2025-11-05T14:21:04.652783Z :FQ_PENDING_FETCHER TRACE: Tasks count: 0
2025-11-05T14:21:05.238709Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: Send ping to [3:7569246154914269600:2118]
2025-11-05T14:21:05.241379Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: NActors::TEvents::TEvPong
2025-11-05T14:21:05.252814Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-11-05T14:21:05.608849Z :YQL_NODES_MANAGER TRACE: TNodesManagerActor::NodesHealthCheck
2025-11-05T14:21:05.619246Z :FQ_PENDING_FETCHER TRACE: Request Private::GetTask, Owner: 3fc00d23-eb88c9ec-a5f5de45-b370629410, Host: ghrun-uqiopzyque, Tenant: /default
2025-11-05T14:21:05.643867Z :FQ_PENDING_FETCHER TRACE: Got GetTask response from PrivateApi
2025-11-05T14:21:05.643903Z :FQ_PENDING_FETCHER TRACE: Tasks count: 0
2025-11-05T14:21:05.696145Z :YQL_NODES_MANAGER TRACE: Send NodeInfo with size: 3 to DynamicNameserver
2025-11-05T14:21:06.619709Z :FQ_PENDING_FETCHER TRACE: Request Private::GetTask, Owner: 3fc00d23-eb88c9ec-a5f5de45-b370629411, Host: ghrun-uqiopzyque, Tenant: /default
2025-11-05T14:21:06.646698Z :FQ_PENDING_FETCHER TRACE: Got GetTask response from PrivateApi
2025-11-05T14:21:06.646724Z :FQ_PENDING_FETCHER TRACE: Tasks count: 0
2025-11-05T14:21:07.239817Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: Send ping to [3:7569246154914269600:2118]
2025-11-05T14:21:07.245075Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: NActors::TEvents::TEvPong
2025-11-05T14:21:07.256823Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-11-05T14:21:07.620836Z :FQ_PENDING_FETCHER TRACE: Request Private::GetTask, Owner: 3fc00d23-eb88c9ec-a5f5de45-b370629412, Host: ghrun-uqiopzyque, Tenant: /default
2025-11-05T14:21:07.657072Z :FQ_PENDING_FETCHER TRACE: Got GetTask response from PrivateApi
2025-11-05T14:21:07.657104Z :FQ_PENDING_FETCHER TRACE: Tasks count: 0
2025-11-05T14:21:07.660486Z :FQ_CONTROL_PLANE_CONFIG TRACE: LOADED TenantInfo: State NOT changed
2025-11-05T14:21:07.876839Z :FQ_QUOTA_SERVICE TRACE: cloud.mock_cloud.yq.cpuPercent.count=0/10000 UPDATE from Peer 1
2025-11-05T14:21:07.922517Z :FQ_QUOTA_SERVICE TRACE: cloud.mock_cloud.yq.analyticsQuery.count=0/100 UPDATE from Peer 1
2025-11-05T14:21:07.922971Z :FQ_QUOTA_SERVICE TRACE: cloud.mock_cloud.yq.streamingQuery.count=0/100 UPDATE from Peer 1
2025-11-05T14:21:08.621154Z :FQ_PENDING_FETCHER TRACE: Request Private::GetTask, Owner: 3fc00d23-eb88c9ec-a5f5de45-b370629413, Host: ghrun-uqiopzyque, Tenant: /default
2025-11-05T14:21:08.656879Z :FQ_PENDING_FETCHER TRACE: Got GetTask response from PrivateApi
2025-11-05T14:21:08.656904Z :FQ_PENDING_FETCHER TRACE: Tasks count: 0
2025-11-05T14:21:09.243014Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: Send ping to [3:7569246154914269600:2118]
2025-11-05T14:21:09.245625Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: NActors::TEvents::TEvPong
2025-11-05T14:21:09.261396Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-11-05T14:21:09.621918Z :FQ_PENDING_FETCHER TRACE: Request Private::GetTask, Owner: 3fc00d23-eb88c9ec-a5f5de45-b370629414, Host: ghrun-uqiopzyque, Tenant: /default
2025-11-05T14:21:09.654310Z :FQ_PENDING_FETCHER TRACE: Got GetTask response from PrivateApi
2025-11-05T14:21:09.654335Z :FQ_PENDING_FETCHER TRACE: Tasks count: 0
2025-11-05T14:21:10.384802Z :FQ_QUOTA_SERVICE TRACE: cloud.mock_cloud.yq.cpuPercent.count=0/10000 UPDATE from Peer 1
2025-11-05T14:21:10.609146Z :YQL_NODES_MANAGER TRACE: TNodesManagerActor::NodesHealthCheck
2025-11-05T14:21:10.624797Z :FQ_PENDING_FETCHER TRACE: Request Private::GetTask, Owner: 3fc00d23-eb88c9ec-a5f5de45-b370629415, Host: ghrun-uqiopzyque, Tenant: /default
2025-11-05T14:21:10.672956Z :FQ_QUOTA_SERVICE TRACE: cloud.mock_cloud.yq.analyticsQuery.count=1/100 UPDATE from Peer 1
2025-11-05T14:21:10.683759Z :FQ_CONTROL_PLANE_CONFIG TRACE: LOADED TenantInfo: State NOT changed
2025-11-05T14:21:10.704565Z :FQ_QUOTA_SERVICE TRACE: cloud.mock_cloud.yq.streamingQuery.count=1/100 UPDATE from Peer 1
2025-11-05T14:21:10.715184Z :YQL_NODES_MANAGER TRACE: Send NodeInfo with size: 3 to DynamicNameserver
2025-11-05T14:21:11.244798Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: Send ping to [3:7569246154914269600:2118]
2025-11-05T14:21:11.247940Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: NActors::TEvents::TEvPong
2025-11-05T14:21:11.264761Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-11-05T14:21:11.422511Z :FQ_PENDING_FETCHER TRACE: Got GetTask response from PrivateApi
2025-11-05T14:21:11.422539Z :FQ_PENDING_FETCHER TRACE: Tasks count: 0
2025-11-05T14:21:11.624117Z :FQ_PENDING_FETCHER TRACE: Request Private::GetTask, Owner: 3fc00d23-eb88c9ec-a5f5de45-b370629416, Host: ghrun-uqiopzyque, Tenant: /default
2025-11-05T14:21:11.668072Z :FQ_PENDING_FETCHER TRACE: Got GetTask response from PrivateApi
2025-11-05T14:21:11.668098Z :FQ_PENDING_FETCHER TRACE: Tasks count: 0
2025-11-05T14:21:12.627585Z :FQ_PENDING_FETCHER TRACE: Request Private::GetTask, Owner: 3fc00d23-eb88c9ec-a5f5de45-b370629417, Host: ghrun-uqiopzyque, Tenant: /default
2025-11-05T14:21:12.660494Z :FQ_PENDING_FETCHER TRACE: Got GetTask response from PrivateApi
2025-11-05T14:21:12.660526Z :FQ_PENDING_FETCHER TRACE: Tasks count: 0
2025-11-05T14:21:13.055103Z :FQ_QUOTA_SERVICE TRACE: cloud.mock_cloud.yq.analyticsQuery.count=1/100 UPDATE from Peer 1
2025-11-05T14:21:13.061935Z :FQ_QUOTA_SERVICE TRACE: cloud.mock_cloud.yq.streamingQuery.count=1/100 UPDATE from Peer 1
2025-11-05T14:21:13.244253Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: Send ping to [3:7569246154914269600:2118]
2025-11-05T14:21:13.258065Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: NActors::TEvents::TEvPong
2025-11-05T14:21:13.268782Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-11-05T14:21:13.550446Z :FQ_QUOTA_SERVICE TRACE: cloud.mock_cloud.yq.cpuPercent.count=0/10000 UPDATE from Peer 1
2025-11-05T14:21:13.628981Z :FQ_PENDING_FETCHER TRACE: Request Private::GetTask, Owner: 3fc00d23-eb88c9ec-a5f5de45-b370629418, Host: ghrun-uqiopzyque, Tenant: /default
2025-11-05T14:21:13.634648Z :FQ_CONTROL_PLANE_CONFIG TRACE: LOADED TenantInfo: State NOT changed
2025-11-05T14:21:13.658201Z :FQ_PENDING_FETCHER TRACE: Got GetTask response from PrivateApi
2025-11-05T14:21:13.658217Z :FQ_PENDING_FETCHER TRACE: Tasks count: 0
2025-11-05T14:21:14.052399Z :INTERCONNECT WARN: Handshake [2:7569246242650678984:2056] [node 4] ICH09 Neither CompatibilityInfo nor VersionTag of the peer can be validated, accepting by default
2025-11-05T14:21:14.094540Z :KQP_COMPUTE DEBUG: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Start compute actor [2:7569246242650678992:2159], task: 2
2025-11-05T14:21:14.094719Z :KQP_COMPUTE DEBUG: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Use CPU quota: 1. Rate limiter resource: { "local/RateLimiter_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/rate_limiter", "mock_cloud/my_folder/ptqudt4pbitcegc3vm0r" }
2025-11-05T14:21:14.439652Z :KQP_COMPUTE DEBUG: [] Task: 2. Got TEvNewCheckpointCoordinator event: generation 1, actorId: [4:7569246240078544544:2166]
2025-11-05T14:21:14.439676Z :KQP_COMPUTE TRACE: [] Task: 2. Assign checkpoint coordinator (generation = 1)
2025-11-05T14:21:14.440383Z :KQP_COMPUTE DEBUG: [ptqudt4pbitcegc3vm0r-0] Task: 2. Handle connected node 4
2025-11-05T14:21:14.633091Z :FQ_PENDING_FETCHER TRACE: Request Private::GetTask, Owner: 3fc00d23-eb88c9ec-a5f5de45-b370629419, Host: ghrun-uqiopzyque, Tenant: /default
2025-11-05T14:21:14.664630Z :FQ_PENDING_FETCHER TRACE: Got GetTask response from PrivateApi
2025-11-05T14:21:14.664656Z :FQ_PENDING_FETCHER TRACE: Tasks count: 0
2025-11-05T14:21:15.066570Z :FQ_QUOTA_SERVICE TRACE: cloud.mock_cloud.yq.cpuPercent.count=0/10000 UPDATE from Peer 1
2025-11-05T14:21:15.092488Z :KQP_COMPUTE DEBUG: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Received channels info: Update { Id: 1 TransportVersion: DATA_TRANSPORT_UV_PICKLE_1_0 SrcTaskId: 1 DstTaskId: 2 SrcEndpoint { ActorId { RawX1: 7569246240078544547 RawX2: 4503616807241848 } } DstEndpoint { ActorId { RawX1: 7569246242650678992 RawX2: 4503608217307247 } } SrcStageId: 200219 DstStageId: 200236 } Update { Id: 2 TransportVersion: DATA_TRANSPORT_UV_PICKLE_1_0 SrcTaskId: 2 SrcEndpoint { ActorId { RawX1: 7569246242650678992 RawX2: 4503608217307247 } } DstEndpoint { ActorId { RawX1: 7569246240078544543 RawX2: 4503616807241845 } } }
2025-11-05T14:21:15.092533Z :KQP_COMPUTE DEBUG: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Update input channelId: 1, peer: [4:7569246240078544547:2168]
2025-11-05T14:21:15.092553Z :KQP_COMPUTE DEBUG: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Update output channelId: 2, peer: [4:7569246240078544543:2165]
2025-11-05T14:21:15.101965Z :FQ_QUOTA_SERVICE TRACE: cloud.mock_cloud.yq.analyticsQuery.count=1/100 UPDATE from Peer 1
2025-11-05T14:21:15.103558Z :FQ_QUOTA_SERVICE TRACE: cloud.mock_cloud.yq.streamingQuery.count=1/100 UPDATE from Peer 1
2025-11-05T14:21:15.244446Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: Send ping to [3:7569246154914269600:2118]
2025-11-05T14:21:15.260685Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: NActors::TEvents::TEvPong
2025-11-05T14:21:15.268697Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-11-05T14:21:15.610145Z :YQL_NODES_MANAGER TRACE: TNodesManagerActor::NodesHealthCheck
2025-11-05T14:21:15.638049Z :FQ_PENDING_FETCHER TRACE: Request Private::GetTask, Owner: 3fc00d23-eb88c9ec-a5f5de45-b370629420, Host: ghrun-uqiopzyque, Tenant: /default
2025-11-05T14:21:15.667218Z :YQL_NODES_MANAGER TRACE: Send NodeInfo with size: 3 to DynamicNameserver
2025-11-05T14:21:15.668606Z :FQ_PENDING_FETCHER TRACE: Got GetTask response from PrivateApi
2025-11-05T14:21:15.668617Z :FQ_PENDING_FETCHER TRACE: Tasks count: 0
2025-11-05T14:21:16.541192Z :KQP_COMPUTE DEBUG: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Got TEvRun from actor [4:7569246240078544544:2166]
2025-11-05T14:21:16.541316Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. Received input for channelId: 1, seqNo: 1, size: 0, chunks: 0, watermark: 0, checkpoint: 1, finished: 0, from: [4:7569246240078544548:2168], expected seqNo: 1
2025-11-05T14:21:16.541334Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. took input
2025-11-05T14:21:16.541424Z :KQP_COMPUTE TRACE: [ptqudt4pbitcegc3vm0r-0] Task: 2. [Checkpoint 1.1] Got checkpoint barrier from channel 1
2025-11-05T14:21:16.541467Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll inputs
2025-11-05T14:21:16.541479Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Skip polling sources because of pending checkpoint
2025-11-05T14:21:16.541497Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. DoExecuteImpl: 1
2025-11-05T14:21:16.541810Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. Peak memory usage: 2031616
2025-11-05T14:21:16.541858Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Input data push finished. Cookie: 0 Watermark: (empty maybe) Ack: 1 TakeInputChannelDataRequests: 1 WatermarkTakeInputChannelDataRequests: 0
2025-11-05T14:21:16.541884Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. Sending channel data ack to channelId: 1, peer: [4:7569246240078544547:2168], from: [2:7569246242650678992:2159], freeSpace: 1000000, seqNo: 1, finished: 0
2025-11-05T14:21:16.541925Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. update task runner stats
2025-11-05T14:21:16.542010Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 1 watermark injected: 0
2025-11-05T14:21:16.542027Z :KQP_COMPUTE DEBUG: [ptqudt4pbitcegc3vm0r-0] Task: 2. [Checkpoint 1.1] Performing task checkpoint
2025-11-05T14:21:16.542042Z :KQP_COMPUTE DEBUG: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Save state
2025-11-05T14:21:16.542056Z :KQP_COMPUTE TRACE: [ptqudt4pbitcegc3vm0r-0] Task: 2. [Checkpoint 1.1] CA state saved
2025-11-05T14:21:16.542070Z :KQP_COMPUTE TRACE: [ptqudt4pbitcegc3vm0r-0] Task: 2. [Checkpoint 1.1] Injecting checkpoint barrier to outputs
2025-11-05T14:21:16.542112Z :KQP_COMPUTE DEBUG: [ptqudt4pbitcegc3vm0r-0] Task: 2. [Checkpoint 1.1] Task checkpoint is done. Send to storage
2025-11-05T14:21:16.542126Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-11-05T14:21:16.542157Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:1000000;inFlightBytes:0;inFlightCount:0;)
2025-11-05T14:21:16.542177Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Ask CPU quota: 150ms
2025-11-05T14:21:16.542226Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll inputs
2025-11-05T14:21:16.542240Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll sources
2025-11-05T14:21:16.542249Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-11-05T14:21:16.542303Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. SendChannelData, channelId: 2, peer: [4:7569246240078544543:2165], chunks: 0, bytes: 0, watermark: 0, checkpoint: 1, seqNo: 1, finished: 0
2025-11-05T14:21:16.542382Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. no poll, channelId: 1, has inflight messages: [1], last with freeSpace: 1000000, current freeSpace: 1000000
2025-11-05T14:21:16.542400Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll inputs
2025-11-05T14:21:16.542405Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll sources
2025-11-05T14:21:16.542411Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-11-05T14:21:16.542443Z :STREAMS_STORAGE_SERVICE DEBUG: [ptqudt4pbitcegc3vm0r-0] [1:1] Got TEvSaveTaskState: task 2
2025-11-05T14:21:16.549595Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. Received channel data ack for channelId: 2, seqNo: 1, lastSentSeqNo: 1, freeSpace: 67108864, early finish: 0
2025-11-05T14:21:16.549648Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. PeerState, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;), sentSeqNo: 1, ackSeqNo: 1
2025-11-05T14:21:16.549660Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. Resume compute actor
2025-11-05T14:21:16.549705Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll inputs
2025-11-05T14:21:16.549716Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll sources
2025-11-05T14:21:16.549726Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-11-05T14:21:16.564335Z :YQ_RATE_LIMITER DEBUG: Scheduled retry in 0.005953s for resource {"/local/RateLimiter_7d4bd615-c9f2-42e3-97d6-4f512c27ed00/rate_limiter", "mock_cloud/my_folder/ptqudt4pbitcegc3vm0r"}. Status: TIMEOUT 
2025-11-05T14:21:16.585417Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. CPU quota delay: 43ms
2025-11-05T14:21:16.585659Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. update task runner stats
2025-11-05T14:21:16.585782Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: 0
2025-11-05T14:21:16.585793Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-11-05T14:21:16.585815Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;)
2025-11-05T14:21:16.585875Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. no poll, channelId: 1, has inflight messages: [1], last with freeSpace: 1000000, current freeSpace: 1000000
2025-11-05T14:21:16.641570Z :FQ_PENDING_FETCHER TRACE: Request Private::GetTask, Owner: 3fc00d23-eb88c9ec-a5f5de45-b370629421, Host: ghrun-uqiopzyque, Tenant: /default
2025-11-05T14:21:16.641654Z :FQ_CONTROL_PLANE_CONFIG TRACE: LOADED TenantInfo: State NOT changed
2025-11-05T14:21:16.676714Z :FQ_PENDING_FETCHER TRACE: Got GetTask response from PrivateApi
2025-11-05T14:21:16.676753Z :FQ_PENDING_FETCHER TRACE: Tasks count: 0
2025-11-05T14:21:16.812748Z :STREAMS_STORAGE_SERVICE DEBUG: [ptqudt4pbitcegc3vm0r-0] [1:1] TEvSaveTaskState Apply: task: 2
2025-11-05T14:21:16.812779Z :STREAMS_STORAGE_SERVICE DEBUG: [ptqudt4pbitcegc3vm0r-0] [1:1] Send TEvSaveTaskStateResult: task: 2
2025-11-05T14:21:17.247243Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: Send ping to [3:7569246154914269600:2118]
2025-11-05T14:21:17.249690Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: NActors::TEvents::TEvPong
2025-11-05T14:21:17.257299Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Got TEvStateRequest from actor [4:7569246240078544544:2166] PingCookie: 1
2025-11-05T14:21:17.257344Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. update task runner stats
2025-11-05T14:21:17.267776Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-11-05T14:21:17.641683Z :FQ_PENDING_FETCHER TRACE: Request Private::GetTask, Owner: 3fc00d23-eb88c9ec-a5f5de45-b370629422, Host: ghrun-uqiopzyque, Tenant: /default
2025-11-05T14:21:17.675827Z :FQ_PENDING_FETCHER TRACE: Got GetTask response from PrivateApi
2025-11-05T14:21:17.675852Z :FQ_PENDING_FETCHER TRACE: Tasks count: 0
2025-11-05T14:21:18.641848Z :FQ_PENDING_FETCHER TRACE: Request Private::GetTask, Owner: 3fc00d23-eb88c9ec-a5f5de45-b370629423, Host: ghrun-uqiopzyque, Tenant: /default
2025-11-05T14:21:18.675490Z :FQ_PENDING_FETCHER TRACE: Got GetTask response from PrivateApi
2025-11-05T14:21:18.675521Z :FQ_PENDING_FETCHER TRACE: Tasks count: 0
2025-11-05T14:21:19.253742Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: Send ping to [3:7569246154914269600:2118]
2025-11-05T14:21:19.255033Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: NActors::TEvents::TEvPong
2025-11-05T14:21:19.268815Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-11-05T14:21:19.568824Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. Received input for channelId: 1, seqNo: 2, size: 0, chunks: 0, watermark: 0, checkpoint: 1, finished: 0, from: [4:7569246240078544548:2168], expected seqNo: 2
2025-11-05T14:21:19.568869Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. took input
2025-11-05T14:21:19.568919Z :KQP_COMPUTE TRACE: [ptqudt4pbitcegc3vm0r-0] Task: 2. [Checkpoint 1.2] Got checkpoint barrier from channel 1
2025-11-05T14:21:19.568998Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll inputs
2025-11-05T14:21:19.569008Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Skip polling sources because of pending checkpoint
2025-11-05T14:21:19.569021Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. DoExecuteImpl: 1
2025-11-05T14:21:19.569057Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Input data push finished. Cookie: 1 Watermark: (empty maybe) Ack: 1 TakeInputChannelDataRequests: 1 WatermarkTakeInputChannelDataRequests: 0
2025-11-05T14:21:19.569080Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. Sending channel data ack to channelId: 1, peer: [4:7569246240078544547:2168], from: [2:7569246242650678992:2159], freeSpace: 1000000, seqNo: 2, finished: 0
2025-11-05T14:21:19.569232Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll inputs
2025-11-05T14:21:19.569241Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Skip polling sources because of pending checkpoint
2025-11-05T14:21:19.569247Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-11-05T14:21:19.569260Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. update task runner stats
2025-11-05T14:21:19.569337Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 1 watermark injected: 0
2025-11-05T14:21:19.569353Z :KQP_COMPUTE DEBUG: [ptqudt4pbitcegc3vm0r-0] Task: 2. [Checkpoint 1.2] Performing task checkpoint
2025-11-05T14:21:19.569364Z :KQP_COMPUTE DEBUG: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Save state
2025-11-05T14:21:19.569377Z :KQP_COMPUTE TRACE: [ptqudt4pbitcegc3vm0r-0] Task: 2. [Checkpoint 1.2] CA state saved
2025-11-05T14:21:19.569390Z :KQP_COMPUTE TRACE: [ptqudt4pbitcegc3vm0r-0] Task: 2. [Checkpoint 1.2] Injecting checkpoint barrier to outputs
2025-11-05T14:21:19.569423Z :KQP_COMPUTE DEBUG: [ptqudt4pbitcegc3vm0r-0] Task: 2. [Checkpoint 1.2] Task checkpoint is done. Send to storage
2025-11-05T14:21:19.569434Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-11-05T14:21:19.569457Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;)
2025-11-05T14:21:19.569569Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. SendChannelData, channelId: 2, peer: [4:7569246240078544543:2165], chunks: 0, bytes: 0, watermark: 0, checkpoint: 1, seqNo: 2, finished: 0
2025-11-05T14:21:19.569627Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. no poll, channelId: 1, has inflight messages: [2], last with freeSpace: 1000000, current freeSpace: 1000000
2025-11-05T14:21:19.569643Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. update task runner stats
2025-11-05T14:21:19.569679Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: 0
2025-11-05T14:21:19.569687Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-11-05T14:21:19.569704Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:96;inFlightCount:1;)
2025-11-05T14:21:19.569720Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll inputs
2025-11-05T14:21:19.569729Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll sources
2025-11-05T14:21:19.569736Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-11-05T14:21:19.569814Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. no poll, channelId: 1, has inflight messages: [2], last with freeSpace: 1000000, current freeSpace: 1000000
2025-11-05T14:21:19.569821Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. update task runner stats
2025-11-05T14:21:19.569849Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: 0
2025-11-05T14:21:19.569855Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-11-05T14:21:19.569867Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:96;inFlightCount:1;)
2025-11-05T14:21:19.569897Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. no poll, channelId: 1, has inflight messages: [2], last with freeSpace: 1000000, current freeSpace: 1000000
2025-11-05T14:21:19.569921Z :STREAMS_STORAGE_SERVICE DEBUG: [ptqudt4pbitcegc3vm0r-0] [1:2] Got TEvSaveTaskState: task 2
2025-11-05T14:21:19.575982Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. Received channel data ack for channelId: 2, seqNo: 2, lastSentSeqNo: 2, freeSpace: 67108864, early finish: 0
2025-11-05T14:21:19.576037Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. PeerState, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;), sentSeqNo: 2, ackSeqNo: 2
2025-11-05T14:21:19.576048Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. Resume compute actor
2025-11-05T14:21:19.576318Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll inputs
2025-11-05T14:21:19.576341Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll sources
2025-11-05T14:21:19.576351Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-11-05T14:21:19.576548Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. update task runner stats
2025-11-05T14:21:19.576631Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: 0
2025-11-05T14:21:19.576642Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-11-05T14:21:19.576669Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;)
2025-11-05T14:21:19.576758Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. no poll, channelId: 1, has inflight messages: [2], last with freeSpace: 1000000, current freeSpace: 1000000
2025-11-05T14:21:19.609705Z :STREAMS_STORAGE_SERVICE DEBUG: [ptqudt4pbitcegc3vm0r-0] [1:2] TEvSaveTaskState Apply: task: 2
2025-11-05T14:21:19.609746Z :STREAMS_STORAGE_SERVICE DEBUG: [ptqudt4pbitcegc3vm0r-0] [1:2] Send TEvSaveTaskStateResult: task: 2
2025-11-05T14:21:19.645550Z :FQ_PENDING_FETCHER TRACE: Request Private::GetTask, Owner: 3fc00d23-eb88c9ec-a5f5de45-b370629424, Host: ghrun-uqiopzyque, Tenant: /default
2025-11-05T14:21:19.670001Z :FQ_CONTROL_PLANE_CONFIG TRACE: LOADED TenantInfo: State NOT changed
2025-11-05T14:21:19.670758Z :FQ_PENDING_FETCHER TRACE: Got GetTask response from PrivateApi
2025-11-05T14:21:19.670772Z :FQ_PENDING_FETCHER TRACE: Tasks count: 0
2025-11-05T14:21:20.281041Z :FQ_QUOTA_SERVICE TRACE: cloud.mock_cloud.yq.cpuPercent.count=0/10000 UPDATE from Peer 1
2025-11-05T14:21:20.322830Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Got TEvStateRequest from actor [4:7569246240078544544:2166] PingCookie: 3
2025-11-05T14:21:20.322890Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. update task runner stats
2025-11-05T14:21:20.338766Z :FQ_QUOTA_SERVICE TRACE: cloud.mock_cloud.yq.streamingQuery.count=1/100 UPDATE from Peer 1
2025-11-05T14:21:20.357851Z :FQ_QUOTA_SERVICE TRACE: cloud.mock_cloud.yq.analyticsQuery.count=1/100 UPDATE from Peer 1
2025-11-05T14:21:20.612155Z :YQL_NODES_MANAGER TRACE: TNodesManagerActor::NodesHealthCheck
2025-11-05T14:21:20.646272Z :FQ_PENDING_FETCHER TRACE: Request Private::GetTask, Owner: 3fc00d23-eb88c9ec-a5f5de45-b370629425, Host: ghrun-uqiopzyque, Tenant: /default
2025-11-05T14:21:20.662631Z :YQL_NODES_MANAGER TRACE: Send NodeInfo with size: 3 to DynamicNameserver
2025-11-05T14:21:20.672893Z :FQ_PENDING_FETCHER TRACE: Got GetTask response from PrivateApi
2025-11-05T14:21:20.672925Z :FQ_PENDING_FETCHER TRACE: Tasks count: 0
2025-11-05T14:21:20.705268Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. Received input for channelId: 1, seqNo: 3, size: 0, chunks: 0, watermark: 0, checkpoint: 1, finished: 0, from: [4:7569246240078544548:2168], expected seqNo: 3
2025-11-05T14:21:20.705304Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. took input
2025-11-05T14:21:20.705344Z :KQP_COMPUTE TRACE: [ptqudt4pbitcegc3vm0r-0] Task: 2. [Checkpoint 1.3] Got checkpoint barrier from channel 1
2025-11-05T14:21:20.705399Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll inputs
2025-11-05T14:21:20.705408Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Skip polling sources because of pending checkpoint
2025-11-05T14:21:20.705418Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. DoExecuteImpl: 1
2025-11-05T14:21:20.705449Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Input data push finished. Cookie: 2 Watermark: (empty maybe) Ack: 1 TakeInputChannelDataRequests: 1 WatermarkTakeInputChannelDataRequests: 0
2025-11-05T14:21:20.705468Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. Sending channel data ack to channelId: 1, peer: [4:7569246240078544547:2168], from: [2:7569246242650678992:2159], freeSpace: 1000000, seqNo: 3, finished: 0
2025-11-05T14:21:20.705628Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll inputs
2025-11-05T14:21:20.705645Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Skip polling sources because of pending checkpoint
2025-11-05T14:21:20.705651Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-11-05T14:21:20.705664Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. update task runner stats
2025-11-05T14:21:20.705726Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 1 watermark injected: 0
2025-11-05T14:21:20.705739Z :KQP_COMPUTE DEBUG: [ptqudt4pbitcegc3vm0r-0] Task: 2. [Checkpoint 1.3] Performing task checkpoint
2025-11-05T14:21:20.705751Z :KQP_COMPUTE DEBUG: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Save state
2025-11-05T14:21:20.705764Z :KQP_COMPUTE TRACE: [ptqudt4pbitcegc3vm0r-0] Task: 2. [Checkpoint 1.3] CA state saved
2025-11-05T14:21:20.705775Z :KQP_COMPUTE TRACE: [ptqudt4pbitcegc3vm0r-0] Task: 2. [Checkpoint 1.3] Injecting checkpoint barrier to outputs
2025-11-05T14:21:20.705803Z :KQP_COMPUTE DEBUG: [ptqudt4pbitcegc3vm0r-0] Task: 2. [Checkpoint 1.3] Task checkpoint is done. Send to storage
2025-11-05T14:21:20.705813Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-11-05T14:21:20.705834Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;)
2025-11-05T14:21:20.705929Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. SendChannelData, channelId: 2, peer: [4:7569246240078544543:2165], chunks: 0, bytes: 0, watermark: 0, checkpoint: 1, seqNo: 3, finished: 0
2025-11-05T14:21:20.705973Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. no poll, channelId: 1, has inflight messages: [3], last with freeSpace: 1000000, current freeSpace: 1000000
2025-11-05T14:21:20.705988Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. update task runner stats
2025-11-05T14:21:20.706016Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: 0
2025-11-05T14:21:20.706022Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-11-05T14:21:20.706035Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:96;inFlightCount:1;)
2025-11-05T14:21:20.706049Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll inputs
2025-11-05T14:21:20.706057Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll sources
2025-11-05T14:21:20.706064Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-11-05T14:21:20.706132Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. no poll, channelId: 1, has inflight messages: [3], last with freeSpace: 1000000, current freeSpace: 1000000
2025-11-05T14:21:20.706140Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. update task runner stats
2025-11-05T14:21:20.706165Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: 0
2025-11-05T14:21:20.706172Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-11-05T14:21:20.706187Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:96;inFlightCount:1;)
2025-11-05T14:21:20.706216Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. no poll, channelId: 1, has inflight messages: [3], last with freeSpace: 1000000, current freeSpace: 1000000
2025-11-05T14:21:20.706240Z :STREAMS_STORAGE_SERVICE DEBUG: [ptqudt4pbitcegc3vm0r-0] [1:3] Got TEvSaveTaskState: task 2
2025-11-05T14:21:20.713138Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. Received channel data ack for channelId: 2, seqNo: 3, lastSentSeqNo: 3, freeSpace: 67108864, early finish: 0
2025-11-05T14:21:20.713168Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. PeerState, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;), sentSeqNo: 3, ackSeqNo: 3
2025-11-05T14:21:20.713178Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. Resume compute actor
2025-11-05T14:21:20.713218Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll inputs
2025-11-05T14:21:20.713234Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll sources
2025-11-05T14:21:20.713245Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-11-05T14:21:20.713391Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. update task runner stats
2025-11-05T14:21:20.713471Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: 0
2025-11-05T14:21:20.713487Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-11-05T14:21:20.713509Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;)
2025-11-05T14:21:20.713564Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. no poll, channelId: 1, has inflight messages: [3], last with freeSpace: 1000000, current freeSpace: 1000000
2025-11-05T14:21:20.724887Z :STREAMS_STORAGE_SERVICE DEBUG: [ptqudt4pbitcegc3vm0r-0] [1:3] TEvSaveTaskState Apply: task: 2
2025-11-05T14:21:20.724920Z :STREAMS_STORAGE_SERVICE DEBUG: [ptqudt4pbitcegc3vm0r-0] [1:3] Send TEvSaveTaskStateResult: task: 2
2025-11-05T14:21:21.256163Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: Send ping to [3:7569246154914269600:2118]
2025-11-05T14:21:21.258131Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: NActors::TEvents::TEvPong
2025-11-05T14:21:21.269014Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-11-05T14:21:21.647561Z :FQ_PENDING_FETCHER TRACE: Request Private::GetTask, Owner: 3fc00d23-eb88c9ec-a5f5de45-b370629426, Host: ghrun-uqiopzyque, Tenant: /default
2025-11-05T14:21:21.677824Z :FQ_PENDING_FETCHER TRACE: Got GetTask response from PrivateApi
2025-11-05T14:21:21.677854Z :FQ_PENDING_FETCHER TRACE: Tasks count: 0
2025-11-05T14:21:21.704224Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. Received input for channelId: 1, seqNo: 4, size: 0, chunks: 0, watermark: 0, checkpoint: 1, finished: 0, from: [4:7569246240078544548:2168], expected seqNo: 4
2025-11-05T14:21:21.704265Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. took input
2025-11-05T14:21:21.704313Z :KQP_COMPUTE TRACE: [ptqudt4pbitcegc3vm0r-0] Task: 2. [Checkpoint 1.4] Got checkpoint barrier from channel 1
2025-11-05T14:21:21.704378Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll inputs
2025-11-05T14:21:21.704389Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Skip polling sources because of pending checkpoint
2025-11-05T14:21:21.704399Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. DoExecuteImpl: 1
2025-11-05T14:21:21.704431Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Input data push finished. Cookie: 3 Watermark: (empty maybe) Ack: 1 TakeInputChannelDataRequests: 1 WatermarkTakeInputChannelDataRequests: 0
2025-11-05T14:21:21.704455Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. Sending channel data ack to channelId: 1, peer: [4:7569246240078544547:2168], from: [2:7569246242650678992:2159], freeSpace: 1000000, seqNo: 4, finished: 0
2025-11-05T14:21:21.704614Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll inputs
2025-11-05T14:21:21.704634Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Skip polling sources because of pending checkpoint
2025-11-05T14:21:21.704642Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-11-05T14:21:21.704662Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. update task runner stats
2025-11-05T14:21:21.704750Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 1 watermark injected: 0
2025-11-05T14:21:21.704770Z :KQP_COMPUTE DEBUG: [ptqudt4pbitcegc3vm0r-0] Task: 2. [Checkpoint 1.4] Performing task checkpoint
2025-11-05T14:21:21.704780Z :KQP_COMPUTE DEBUG: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Save state
2025-11-05T14:21:21.704793Z :KQP_COMPUTE TRACE: [ptqudt4pbitcegc3vm0r-0] Task: 2. [Checkpoint 1.4] CA state saved
2025-11-05T14:21:21.704805Z :KQP_COMPUTE TRACE: [ptqudt4pbitcegc3vm0r-0] Task: 2. [Checkpoint 1.4] Injecting checkpoint barrier to outputs
2025-11-05T14:21:21.704834Z :KQP_COMPUTE DEBUG: [ptqudt4pbitcegc3vm0r-0] Task: 2. [Checkpoint 1.4] Task checkpoint is done. Send to storage
2025-11-05T14:21:21.704843Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-11-05T14:21:21.704863Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;)
2025-11-05T14:21:21.704998Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. SendChannelData, channelId: 2, peer: [4:7569246240078544543:2165], chunks: 0, bytes: 0, watermark: 0, checkpoint: 1, seqNo: 4, finished: 0
2025-11-05T14:21:21.705054Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. no poll, channelId: 1, has inflight messages: [4], last with freeSpace: 1000000, current freeSpace: 1000000
2025-11-05T14:21:21.705069Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. update task runner stats
2025-11-05T14:21:21.705117Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: 0
2025-11-05T14:21:21.705126Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-11-05T14:21:21.705146Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:96;inFlightCount:1;)
2025-11-05T14:21:21.705161Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll inputs
2025-11-05T14:21:21.705169Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll sources
2025-11-05T14:21:21.705176Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-11-05T14:21:21.705288Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. no poll, channelId: 1, has inflight messages: [4], last with freeSpace: 1000000, current freeSpace: 1000000
2025-11-05T14:21:21.705303Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. update task runner stats
2025-11-05T14:21:21.705339Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: 0
2025-11-05T14:21:21.705347Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-11-05T14:21:21.705361Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:96;inFlightCount:1;)
2025-11-05T14:21:21.705401Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. no poll, channelId: 1, has inflight messages: [4], last with freeSpace: 1000000, current freeSpace: 1000000
2025-11-05T14:21:21.705438Z :STREAMS_STORAGE_SERVICE DEBUG: [ptqudt4pbitcegc3vm0r-0] [1:4] Got TEvSaveTaskState: task 2
2025-11-05T14:21:21.707017Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. Received channel data ack for channelId: 2, seqNo: 4, lastSentSeqNo: 4, freeSpace: 67108864, early finish: 0
2025-11-05T14:21:21.707038Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. PeerState, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;), sentSeqNo: 4, ackSeqNo: 4
2025-11-05T14:21:21.707048Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. Resume compute actor
2025-11-05T14:21:21.707075Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll inputs
2025-11-05T14:21:21.707084Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll sources
2025-11-05T14:21:21.707091Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-11-05T14:21:21.707200Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. update task runner stats
2025-11-05T14:21:21.707247Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: 0
2025-11-05T14:21:21.707259Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-11-05T14:21:21.707277Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;)
2025-11-05T14:21:21.707319Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. no poll, channelId: 1, has inflight messages: [4], last with freeSpace: 1000000, current freeSpace: 1000000
2025-11-05T14:21:21.736908Z :STREAMS_STORAGE_SERVICE DEBUG: [ptqudt4pbitcegc3vm0r-0] [1:4] TEvSaveTaskState Apply: task: 2
2025-11-05T14:21:21.736939Z :STREAMS_STORAGE_SERVICE DEBUG: [ptqudt4pbitcegc3vm0r-0] [1:4] Send TEvSaveTaskStateResult: task: 2
2025-11-05T14:21:22.650183Z :FQ_PENDING_FETCHER TRACE: Request Private::GetTask, Owner: 3fc00d23-eb88c9ec-a5f5de45-b370629427, Host: ghrun-uqiopzyque, Tenant: /default
2025-11-05T14:21:22.796844Z :FQ_CONTROL_PLANE_CONFIG TRACE: LOADED TenantInfo: State NOT changed
2025-11-05T14:21:22.828314Z :FQ_PENDING_FETCHER TRACE: Got GetTask response from PrivateApi
2025-11-05T14:21:22.828345Z :FQ_PENDING_FETCHER TRACE: Tasks count: 0
2025-11-05T14:21:22.948708Z :FQ_QUOTA_SERVICE TRACE: cloud.mock_cloud.yq.cpuPercent.count=0/10000 UPDATE from Peer 1
2025-11-05T14:21:22.955405Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. Received input for channelId: 1, seqNo: 5, size: 0, chunks: 0, watermark: 0, checkpoint: 1, finished: 0, from: [4:7569246240078544548:2168], expected seqNo: 5
2025-11-05T14:21:22.955426Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. took input
2025-11-05T14:21:22.955472Z :KQP_COMPUTE TRACE: [ptqudt4pbitcegc3vm0r-0] Task: 2. [Checkpoint 1.5] Got checkpoint barrier from channel 1
2025-11-05T14:21:22.955531Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll inputs
2025-11-05T14:21:22.955540Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Skip polling sources because of pending checkpoint
2025-11-05T14:21:22.955551Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. DoExecuteImpl: 1
2025-11-05T14:21:22.955583Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Input data push finished. Cookie: 4 Watermark: (empty maybe) Ack: 1 TakeInputChannelDataRequests: 1 WatermarkTakeInputChannelDataRequests: 0
2025-11-05T14:21:22.955603Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. Sending channel data ack to channelId: 1, peer: [4:7569246240078544547:2168], from: [2:7569246242650678992:2159], freeSpace: 1000000, seqNo: 5, finished: 0
2025-11-05T14:21:22.955752Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll inputs
2025-11-05T14:21:22.955759Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Skip polling sources because of pending checkpoint
2025-11-05T14:21:22.955765Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-11-05T14:21:22.955780Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. update task runner stats
2025-11-05T14:21:22.955851Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 1 watermark injected: 0
2025-11-05T14:21:22.955864Z :KQP_COMPUTE DEBUG: [ptqudt4pbitcegc3vm0r-0] Task: 2. [Checkpoint 1.5] Performing task checkpoint
2025-11-05T14:21:22.955875Z :KQP_COMPUTE DEBUG: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Save state
2025-11-05T14:21:22.955889Z :KQP_COMPUTE TRACE: [ptqudt4pbitcegc3vm0r-0] Task: 2. [Checkpoint 1.5] CA state saved
2025-11-05T14:21:22.955900Z :KQP_COMPUTE TRACE: [ptqudt4pbitcegc3vm0r-0] Task: 2. [Checkpoint 1.5] Injecting checkpoint barrier to outputs
2025-11-05T14:21:22.955931Z :KQP_COMPUTE DEBUG: [ptqudt4pbitcegc3vm0r-0] Task: 2. [Checkpoint 1.5] Task checkpoint is done. Send to storage
2025-11-05T14:21:22.955943Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-11-05T14:21:22.955965Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;)
2025-11-05T14:21:22.956069Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. SendChannelData, channelId: 2, peer: [4:7569246240078544543:2165], chunks: 0, bytes: 0, watermark: 0, checkpoint: 1, seqNo: 5, finished: 0
2025-11-05T14:21:22.956112Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. no poll, channelId: 1, has inflight messages: [5], last with freeSpace: 1000000, current freeSpace: 1000000
2025-11-05T14:21:22.956124Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. update task runner stats
2025-11-05T14:21:22.956153Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: 0
2025-11-05T14:21:22.956162Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-11-05T14:21:22.956179Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:96;inFlightCount:1;)
2025-11-05T14:21:22.956197Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll inputs
2025-11-05T14:21:22.956205Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll sources
2025-11-05T14:21:22.956213Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-11-05T14:21:22.956283Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. no poll, channelId: 1, has inflight messages: [5], last with freeSpace: 1000000, current freeSpace: 1000000
2025-11-05T14:21:22.956290Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. update task runner stats
2025-11-05T14:21:22.956315Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: 0
2025-11-05T14:21:22.956322Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-11-05T14:21:22.956337Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:96;inFlightCount:1;)
2025-11-05T14:21:22.956363Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. no poll, channelId: 1, has inflight messages: [5], last with freeSpace: 1000000, current freeSpace: 1000000
2025-11-05T14:21:22.956387Z :STREAMS_STORAGE_SERVICE DEBUG: [ptqudt4pbitcegc3vm0r-0] [1:5] Got TEvSaveTaskState: task 2
2025-11-05T14:21:22.959666Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. Received channel data ack for channelId: 2, seqNo: 5, lastSentSeqNo: 5, freeSpace: 67108864, early finish: 0
2025-11-05T14:21:22.959712Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. PeerState, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;), sentSeqNo: 5, ackSeqNo: 5
2025-11-05T14:21:22.959731Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. Resume compute actor
2025-11-05T14:21:22.959988Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll inputs
2025-11-05T14:21:22.959998Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Poll sources
2025-11-05T14:21:22.960007Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. DoExecuteImpl: 0
2025-11-05T14:21:22.960159Z :YQL_PROXY DEBUG: SessionId: 3fc00d23-eb88c9ec-a5f5de45-b3706294 2025-11-05 14:21:22.960 DEBUG ydbd(pid=829863, tid=0x00007F148F886640) [DQ] tasks_runner_local.cpp:267: {TODO/2} Run task: 2, Run task: 2

2025-11-05T14:21:22.960226Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. update task runner stats
2025-11-05T14:21:22.960295Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Resume execution, run status: PendingInput checkpoint: 0 watermark injected: 0
2025-11-05T14:21:22.960310Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. ProcessOutputsState.Inflight: 0
2025-11-05T14:21:22.960333Z :KQP_COMPUTE TRACE: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. About to drain channelId: 2, hasPeer: 1, peerState:(freeSpace:67108864;inFlightBytes:0;inFlightCount:0;)
2025-11-05T14:21:22.960394Z :KQP_COMPUTE TRACE: TxId: ptqudt4pbitcegc3vm0r, task: 2. no poll, channelId: 1, has inflight messages: [5], last with freeSpace: 1000000, current freeSpace: 1000000
2025-11-05T14:21:22.975467Z :STREAMS_STORAGE_SERVICE DEBUG: [ptqudt4pbitcegc3vm0r-0] [1:5] TEvSaveTaskState Apply: task: 2
2025-11-05T14:21:22.975490Z :STREAMS_STORAGE_SERVICE DEBUG: [ptqudt4pbitcegc3vm0r-0] [1:5] Send TEvSaveTaskStateResult: task: 2
2025-11-05T14:21:22.992970Z :FQ_QUOTA_SERVICE TRACE: cloud.mock_cloud.yq.analyticsQuery.count=1/100 UPDATE from Peer 1
2025-11-05T14:21:22.994663Z :FQ_QUOTA_SERVICE TRACE: cloud.mock_cloud.yq.streamingQuery.count=1/100 UPDATE from Peer 1
2025-11-05T14:21:23.260827Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: Send ping to [3:7569246154914269600:2118]
2025-11-05T14:21:23.262009Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: NActors::TEvents::TEvPong
2025-11-05T14:21:23.271502Z :FQ_ROW_DISPATCHER TRACE: RowDispatcher: TEvPrivate::TEvSendStatistic
2025-11-05T14:21:23.390154Z :KQP_COMPUTE ERROR: SelfId: [2:7569246242650678992:2159], TxId: ptqudt4pbitcegc3vm0r, task: 2. Ctx: {}. Handle abort execution event from: [2:7569246161046300235:2068], status: UNAVAILABLE, reason: { <main>: Error: Aborted by LWM }
2025-11-05T14:21:23.390313Z :KQP_COMPUTE DEBUG: TxId: ptqudt4pbitcegc3vm0r, task: 2. pass away
2025-11-05T14:21:23.650926Z :FQ_PENDING_FETCHER TRACE: Request Private::GetTask, Owner: 3fc00d23-eb88c9ec-a5f5de45-b370629428, Host: ghrun-uqiopzyque, Tenant: /default
2025-11-05T14:21:23.679574Z :FQ_PENDING_FETCHER TRACE: Got GetTask response from PrivateApi
2025-11-05T14:21:23.679597Z :FQ_PENDING_FETCHER TRACE: Tasks count: 0
2025-11-05T14:21:24.652631Z :FQ_PENDING_FETCHER TRACE: Request Private::GetTask, Owner: 3fc00d23-eb88c9ec-a5f5de45-b370629429, Host: ghrun-uqiopzyque, Tenant: /default
2025-11-05T14:21:24.682708Z :FQ_PENDING_FETCHER TRACE: Got GetTask response from PrivateApi
2025-11-05T14:21:24.682726Z :FQ_PENDING_FETCHER TRACE: Tasks count: 0
2025-11-05T14:21:25.076284Z :FQ_QUOTA_SERVICE TRACE: cloud.mock_cloud.yq.cpuPercent.count=0/10000 UPDATE from Peer 1
2025-11-05T14:21:25.081429Z :FQ_QUOTA_SERVICE TRACE: cloud.mock_cloud.yq.streamingQuery.count=0/100 UPDATE from Peer 1
2025-11-05T14:21:25.085202Z :INTERCONNECT_NETWORK NOTICE: [2 <-> 1] connection closed by peer
