============================= test session starts ==============================
platform linux -- Python 3.12.12, pytest-8.0.2, pluggy-1.6.0
rootdir: /home/runner/.ya/build/build_root/dyq9/002674/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_cp_ic
configfile: pkg:library.python.pytest:pytest.yatest.ini
plugins: typeguard-2.13.3
collected 1 item

test_cp_ic.py .

============================== slowest durations ===============================
1.17s setup    test_cp_ic.py::TestCpIc::test_discovery
1.01s teardown test_cp_ic.py::TestCpIc::test_discovery
0.61s call     test_cp_ic.py::TestCpIc::test_discovery
============================== 1 passed in 3.30s ===============================
============================= test session starts ==============================
platform linux -- Python 3.12.12, pytest-8.0.2, pluggy-1.6.0
rootdir: /home/runner/.ya/build/build_root/dyq9/002678/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_dispatch
configfile: pkg:library.python.pytest:pytest.yatest.ini
plugins: typeguard-2.13.3
collected 5 items

test_dispatch.py .....

============================== slowest durations ===============================
18.70s call     test_dispatch.py::TestMapping::test_idle
13.81s call     test_dispatch.py::TestMapping::test_mapping
13.69s call     test_dispatch.py::TestMapping::test_mapping_with_nodes
11.57s call     test_dispatch.py::TestMapping::test_mapping_with_row_dispatcher
10.97s call     test_dispatch.py::TestMapping::test_mapping_with_nodes_with_scheduler
6.09s teardown test_dispatch.py::TestMapping::test_idle
5.06s teardown test_dispatch.py::TestMapping::test_mapping
5.02s teardown test_dispatch.py::TestMapping::test_mapping_with_nodes_with_scheduler
4.78s setup    test_dispatch.py::TestMapping::test_idle
4.50s setup    test_dispatch.py::TestMapping::test_mapping_with_nodes
4.06s setup    test_dispatch.py::TestMapping::test_mapping
3.17s setup    test_dispatch.py::TestMapping::test_mapping_with_nodes_with_scheduler
3.05s teardown test_dispatch.py::TestMapping::test_mapping_with_nodes
3.01s teardown test_dispatch.py::TestMapping::test_mapping_with_row_dispatcher
2.78s setup    test_dispatch.py::TestMapping::test_mapping_with_row_dispatcher
======================== 5 passed in 110.83s (0:01:50) =========================
============================= test session starts ==============================
platform linux -- Python 3.12.12, pytest-8.0.2, pluggy-1.6.0
rootdir: /home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry
configfile: pkg:library.python.pytest:pytest.yatest.ini
plugins: typeguard-2.13.3
collected 2 items

test_retry.py .FE

==================================== ERRORS ====================================
____________ ERROR at teardown of TestRetry.test_low_rate[kikimr0] _____________
ydb/tests/fq/multi_plane/test_retry.py:51: in kikimr
    kikimr.stop()
ydb/tests/tools/fq_runner/kikimr_runner.py:748: in stop
    tenant.stop()
ydb/tests/tools/fq_runner/kikimr_runner.py:62: in stop
    self.kikimr_cluster.stop(kill=False)
ydb/tests/library/harness/kikimr_runner.py:658: in stop
    raise daemon.SeveralDaemonErrors(saved_exceptions)
E   ydb.tests.library.harness.daemon.SeveralDaemonErrors: Daemon failed with message: Unexpectedly finished before stop.
E   Process exit_code = 1.
E   Stdout file name: 
E   /home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/node_1/stdout
E   Stderr file name: 
E   /home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/node_1/stderr
E   Stderr content:
E   
E   GRpc memory quota was set but disabled due to issues with grpc quoter, to enable it use EnableGRpcMemoryQuota option
E   GRpc memory quota was set but disabled due to issues with grpc quoter, to enable it use EnableGRpcMemoryQuota option
E   GRpc shutdown warning: left infly: 1, spent: 3.287737 sec. GRpcShutdownDeadline: 30
E   GRpc shutdown warning: left infly: 1, spent: 6.533646 sec. GRpcShutdownDeadline: 30
E   GRpc shutdown warning: left infly: 1, spent: 9.669783 sec. GRpcShutdownDeadline: 30
E   GRpc shutdown warning: left infly: 1, spent: 12.77468 sec. GRpcShutdownDeadline: 30
E   GRpc shutdown warning: left infly: 1, spent: 15.911675 sec. GRpcShutdownDeadline: 30
E   GRpc shutdown warning: left infly: 1, spent: 19.038655 sec. GRpcShutdownDeadline: 30
E   GRpc shutdown warning: left infly: 1, spent: 22.132918 sec. GRpcShutdownDeadline: 30
E   GRpc shutdown warning: left infly: 1, spent: 25.229911 sec. GRpcShutdownDeadline: 30
E   GRpc shutdown warning: left infly: 1, spent: 28.310882 sec. GRpcShutdownDeadline: 30
E   GRpc shutdown warning: failed to shutdown all connections, left infly: 1, spent: 30.006847 sec. GRpcShutdownDeadline: 30
E   Caught exception: ydb/core/driver_lib/run/kikimr_services_initializers.cpp:850: Failed to set up IC listener on port 21282 errno# 98 (Address already in use)
------------------------------ Captured log setup ------------------------------
INFO     ya.test:ya.py:420 ####################################################################################################
INFO     ya.test:ya.py:421 test_low_rate[kikimr0]
INFO     ya.test:ya.py:422 ####################################################################################################
INFO     ya.test:ya.py:423 Test setup
DEBUG    library.python.filelock:__init__.py:115 Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/26960
DEBUG    library.python.filelock:__init__.py:115 Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18081
DEBUG    ya.test:ya.py:181 Binary was found by /home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd
DEBUG    library.python.filelock:__init__.py:115 Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/21282
DEBUG    library.python.filelock:__init__.py:115 Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/23758
DEBUG    ydb.connection:connection.py:314 Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
DEBUG    ydb.resolver.DiscoveryEndpointsResolver:resolver.py:175 Preparing initial endpoint to resolve endpoints
DEBUG    ydb.connection:connection.py:314 Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
DEBUG    ydb.resolver.DiscoveryEndpointsResolver:resolver.py:185 Resolving endpoints for database local
DEBUG    ydb.connection:connection.py:421 RpcState(ListEndpoints, 7396c8a0-3611-424d-9d25-8c79570e815c, localhost:27912): creating call state
DEBUG    ydb.connection:connection.py:63 RpcState(ListEndpoints, 7396c8a0-3611-424d-9d25-8c79570e815c, localhost:27912): request = { database: "local" }
DEBUG    ydb.connection:connection.py:52 RpcState(ListEndpoints, 7396c8a0-3611-424d-9d25-8c79570e815c, localhost:27912): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-aathosbtb4.auto.internal" port: 27912 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
DEBUG    ydb.resolver.DiscoveryEndpointsResolver:resolver.py:155 Resolved endpoints for database local: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-aathosbtb4.auto.internal:27912, location 1, ssl: False>]>
DEBUG    ydb.connection:connection.py:314 Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
DEBUG    ydb.connection:connection.py:549 Closing channel for endpoint localhost:27912
DEBUG    ydb.table.SessionPool:_sp_impl.py:260 Active session queue is empty, subscribe waiter for a session
DEBUG    ydb.table.SessionPool:_sp_impl.py:262 Subscribe waiter <Future at 0x7ff34d6d08d0 state=pending>
DEBUG    ydb.table.SessionPool:_sp_impl.py:282 Session pool is not large enough (active_count < size: 0 < 1). will create a new session.
DEBUG    ydb.table.SessionPool:_sp_impl.py:111 Created session <ydb.table.Session object at 0x7ff34d6d3210>
DEBUG    ydb.table.SessionPool:_sp_impl.py:238 Preparing session <ydb.table.Session object at 0x7ff34d6d3210>
DEBUG    ydb.connection:connection.py:421 RpcState(CreateSession, f6408774-4a9b-4933-bdbd-beed0926b1de, ghrun-aathosbtb4.auto.internal:27912): creating call state
DEBUG    ydb.connection:connection.py:63 RpcState(CreateSession, f6408774-4a9b-4933-bdbd-beed0926b1de, ghrun-aathosbtb4.auto.internal:27912): request = { operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
DEBUG    ydb.connection:connection.py:118 RpcState(CreateSession, f6408774-4a9b-4933-bdbd-beed0926b1de, ghrun-aathosbtb4.auto.internal:27912): on response callback started
DEBUG    ydb.connection:connection.py:52 RpcState(CreateSession, f6408774-4a9b-4933-bdbd-beed0926b1de, ghrun-aathosbtb4.auto.internal:27912): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=M2VhNDc0OTItNGVhOWYxNGUtZWJmNzc4NWMtNTI3NjVkMTU=" } } } }
DEBUG    ydb.connection:connection.py:123 RpcState(CreateSession, f6408774-4a9b-4933-bdbd-beed0926b1de, ghrun-aathosbtb4.auto.internal:27912): on response callback success
DEBUG    ydb.table.SessionPool:_sp_impl.py:177 Put on session <ydb.table.Session object at 0x7ff34d6d3210>
DEBUG    ydb.table.SessionPool:_sp_impl.py:195 Replying to waiter with a session <ydb.table.Session object at 0x7ff34d6d3210>
DEBUG    ydb.connection:connection.py:421 RpcState(CreateTable, 00759c3f-af6e-4129-8f82-f37fd287f928, ghrun-aathosbtb4.auto.internal:27912): creating call state
DEBUG    ydb.connection:connection.py:63 RpcState(CreateTable, 00759c3f-af6e-4129-8f82-f37fd287f928, ghrun-aathosbtb4.auto.internal:27912): request = { session_id: "ydb://session/3?node_id=1&id=M2VhNDc0OTItNGVhOWYxNGUtZWJmNzc4NWMtNTI3NjVkMTU=" path: "local/DbPoolStorage_cb360dc2-0778-4f13-83c6-b7a0787a95fc/tenants" columns { name: "tenant" type { optional_type { item { type_id: STRING } } } } columns { name: "vtenant" type { optional_type { item { type_id: STRING } } } } columns { name: "common" type { optional_type { item { type_id: BOOL } } } } columns { name: "state" type { optional_type { item { type_id: UINT32 } } } } columns { name: "state_time" type { optional_type { item { type_id: TIMESTAMP } } } } primary_key: "tenant" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
DEBUG    ydb.connection:connection.py:52 RpcState(CreateTable, 00759c3f-af6e-4129-8f82-f37fd287f928, ghrun-aathosbtb4.auto.internal:27912): response = { operation { ready: true status: SUCCESS } }
DEBUG    ydb.table.SessionPool:_sp_impl.py:177 Put on session <ydb.table.Session object at 0x7ff34d6d3210>
DEBUG    ydb.connection:connection.py:421 RpcState(CreateTable, 5f88affd-5538-467d-bd90-1fd5646e03af, ghrun-aathosbtb4.auto.internal:27912): creating call state
DEBUG    ydb.connection:connection.py:63 RpcState(CreateTable, 5f88affd-5538-467d-bd90-1fd5646e03af, ghrun-aathosbtb4.auto.internal:27912): request = { session_id: "ydb://session/3?node_id=1&id=M2VhNDc0OTItNGVhOWYxNGUtZWJmNzc4NWMtNTI3NjVkMTU=" path: "local/DbPoolStorage_cb360dc2-0778-4f13-83c6-b7a0787a95fc/mappings" columns { name: "subject_type" type { optional_type { item { type_id: STRING } } } } columns { name: "subject_id" type { optional_type { item { type_id: STRING } } } } columns { name: "vtenant" type { optional_type { item { type_id: STRING } } } } columns { name: "node" type { optional_type { item { type_id: STRING } } } } primary_key: "subject_type" primary_key: "subject_id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
DEBUG    ydb.connection:connection.py:52 RpcState(CreateTable, 5f88affd-5538-467d-bd90-1fd5646e03af, ghrun-aathosbtb4.auto.internal:27912): response = { operation { ready: true status: SUCCESS } }
DEBUG    ydb.table.SessionPool:_sp_impl.py:177 Put on session <ydb.table.Session object at 0x7ff34d6d3210>
DEBUG    ydb.connection:connection.py:421 RpcState(ExecuteDataQuery, 3e4f5cfa-a28e-49c0-9b42-8ec2dc59847b, ghrun-aathosbtb4.auto.internal:27912): creating call state
DEBUG    ydb.connection:connection.py:63 RpcState(ExecuteDataQuery, 3e4f5cfa-a28e-49c0-9b42-8ec2dc59847b, ghrun-aathosbtb4.auto.internal:27912): request = { session_id: "ydb://session/3?node_id=1&id=M2VhNDc0OTItNGVhOWYxNGUtZWJmNzc4NWMtNTI3NjVkMTU=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "--!syntax_v1\n            PRAGMA TablePathPrefix(\"local/DbPoolStorage_cb360dc2-0778-4f13-83c6-b7a0787a95fc\");\n            UPSERT INTO tenants (tenant, vtenant, common, state, state_time) values(\"/default\", \"/default\", true, 0, CurrentUtcTimestamp());\n                " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
DEBUG    ydb.connection:connection.py:52 RpcState(ExecuteDataQuery, 3e4f5cfa-a28e-49c0-9b42-8ec2dc59847b, ghrun-aathosbtb4.auto.internal:27912): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
DEBUG    ydb.table.SessionPool:_sp_impl.py:177 Put on session <ydb.table.Session object at 0x7ff34d6d3210>
DEBUG    ya.test:ya.py:181 Binary was found by /home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd
DEBUG    library.python.filelock:__init__.py:115 Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/5619
DEBUG    library.python.filelock:__init__.py:115 Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/6606
DEBUG    library.python.filelock:__init__.py:115 Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/27097
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:264 CFG_DIR_PATH="/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/kikimr_configs"
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:265 Final command: /home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=1 --tenant=/default --node-kind=yq --log-file-name=/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/node_1/logfile_u4wkaukr.log --grpc-port=23758 --mon-port=5619 --ic-port=21282 --module=1
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:264 CFG_DIR_PATH="/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/kikimr_configs"
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:265 Final command: /home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=1 --tenant=/default --node-kind=yq --log-file-name=/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/node_1/logfile_u4wkaukr.log --grpc-port=23758 --mon-port=5619 --ic-port=21282 --module=1
DEBUG    ya.test:process.py:610 Executing '('/home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/kikimr_configs/config.yaml', '--node=1', '--tenant=/default', '--node-kind=yq', '--log-file-name=/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/node_1/logfile_u4wkaukr.log', '--grpc-port=23758', '--mon-port=5619', '--ic-port=21282', '--module=1')' in '/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/node_1' (no wait)
DEBUG    ya.test:process.py:628 Command pid: 1717436
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:305 Started node localhost:23758/1
DEBUG    ya.test:process.py:678 Command out will be placed to ydbd.out.1
DEBUG    ya.test:process.py:678 Command err will be placed to ydbd.err.1
DEBUG    ya.test:process.py:610 Executing '['/home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
DEBUG    ya.test:process.py:628 Command pid: 1717482
DEBUG    ya.test:process.py:259 Command (pid 1717482) rc: 0
DEBUG    ya.test:process.py:260 Command (pid 1717482) elapsed time (sec): 0.9586708545684814
DEBUG    ya.test:process.py:263 Command (pid 1717482) idrss: 0
DEBUG    ya.test:process.py:263 Command (pid 1717482) inblock: 0
DEBUG    ya.test:process.py:263 Command (pid 1717482) isrss: 0
DEBUG    ya.test:process.py:263 Command (pid 1717482) ixrss: 0
DEBUG    ya.test:process.py:263 Command (pid 1717482) majflt: 0
DEBUG    ya.test:process.py:263 Command (pid 1717482) maxrss: 540192
DEBUG    ya.test:process.py:263 Command (pid 1717482) minflt: 16126
DEBUG    ya.test:process.py:263 Command (pid 1717482) msgrcv: 0
DEBUG    ya.test:process.py:263 Command (pid 1717482) msgsnd: 0
DEBUG    ya.test:process.py:263 Command (pid 1717482) nivcsw: 179
DEBUG    ya.test:process.py:263 Command (pid 1717482) nsignals: 0
DEBUG    ya.test:process.py:263 Command (pid 1717482) nswap: 0
DEBUG    ya.test:process.py:263 Command (pid 1717482) nvcsw: 18
DEBUG    ya.test:process.py:263 Command (pid 1717482) oublock: 8
DEBUG    ya.test:process.py:263 Command (pid 1717482) stime: 0.746468
DEBUG    ya.test:process.py:263 Command (pid 1717482) utime: 0.127327
DEBUG    ya.test:process.py:263 Command (pid 1717482) wtime: 0.966
DEBUG    ya.test:process.py:275 Command (pid 1717482) output:
Git info:
    Commit: adb44c074251a1871f952a1fe07a46be1893a61c
    Branch: 
    Author: nfrmtk <nfrmtk.aka.fkfka@gmail.com>
    Summary: Merge 48882a55d21ba4abb146d6a9c2cd1aadf2a909fc into 959c4f93fed7b73b12b83b26b671758583f027f9

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-aathosbtb4
    Host information: 
        Linux ghrun-aathosbtb4 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

    
Build info:
    Compiler: /home/runner/.ya/tools/v4/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -UNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -UNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

DEBUG    ya.test:process.py:276 Command (pid 1717482) errors:

INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:306 Node 1 version:
Git info:
    Commit: adb44c074251a1871f952a1fe07a46be1893a61c
    Branch: 
    Author: nfrmtk <nfrmtk.aka.fkfka@gmail.com>
    Summary: Merge 48882a55d21ba4abb146d6a9c2cd1aadf2a909fc into 959c4f93fed7b73b12b83b26b671758583f027f9
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:527 Cluster started and initialized
------------------------------ Captured log call -------------------------------
INFO     ya.test:ya.py:436 Test call (class_name: test_retry.py::TestRetry, test_name: test_low_rate[kikimr0])
DEBUG    root:control_plane.py:61 Requesting CreateStream.
Database: "local".
Request:
stream_name: "/local/low_rate_input"
shard_count: 1
write_quota_kb_per_sec: 1024
retention_period_hours: 1

DEBUG    root:control_plane.py:45 Response: operation {
  ready: true
  status: SUCCESS
}

DEBUG    root:control_plane.py:49 Result: 
DEBUG    root:control_plane.py:61 Requesting CreateStream.
Database: "local".
Request:
stream_name: "/local/low_rate_output"
shard_count: 1
write_quota_kb_per_sec: 1024
retention_period_hours: 1

DEBUG    root:control_plane.py:45 Response: operation {
  ready: true
  status: SUCCESS
}

DEBUG    root:control_plane.py:49 Result: 
DEBUG    root:control_plane.py:45 Response: operation {
  ready: true
  status: SUCCESS
}

DEBUG    root:control_plane.py:49 Result: 
DEBUG    root:fq_client.py:170 Request: content {
  type: STREAMING
  name: "a"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "SELECT * FROM low_rate.`low_rate_input`;"
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "1d999e03-37a5-44ff-9392-86babf8c4dcc"

DEBUG    root:fq_client.py:180 Result: query_id: "ptqudts2o4ptk3uvqt9p"

DEBUG    root:fq_client.py:284 Result: query {
  meta {
    common {
      id: "ptqudts2o4ptk3uvqt9p"
      created_by: "root@builtin"
      modified_by: "root@builtin"
      created_at {
        seconds: 1761552108
        nanos: 816662000
      }
      modified_at {
        seconds: 1761552108
        nanos: 816662000
      }
      revision: 1
    }
    execute_mode: RUN
    status: STARTING
    last_job_query_revision: 1
    last_job_id: "ptjudts2o4ptjuvf6no8-ptqudts2o4ptk3uvqt9p"
    started_by: "root@builtin"
    submitted_at {
      seconds: 1761552108
      nanos: 816662000
    }
  }
  content {
    type: STREAMING
    name: "a"
    acl {
      visibility: PRIVATE
    }
    limits {
      execution_timeout {
      }
    }
    text: "SELECT * FROM low_rate.`low_rate_input`;"
    syntax: YQL_V1
  }
}

DEBUG    root:fq_client.py:284 Result: query {
  meta {
    common {
      id: "ptqudts2o4ptk3uvqt9p"
      created_by: "root@builtin"
      modified_by: "root@builtin"
      created_at {
        seconds: 1761552108
        nanos: 816662000
      }
      modified_at {
        seconds: 1761552108
        nanos: 816662000
      }
      revision: 1
    }
    started_at {
      seconds: 1761552109
      nanos: 340000000
    }
    execute_mode: RUN
    status: RUNNING
    last_job_query_revision: 1
    last_job_id: "ptjudts2o4ptjuvf6no8-ptqudts2o4ptk3uvqt9p"
    started_by: "root@builtin"
    submitted_at {
      seconds: 1761552108
      nanos: 816662000
    }
  }
  content {
    type: STREAMING
    name: "a"
    acl {
      visibility: PRIVATE
    }
    limits {
      execution_timeout {
      }
    }
    text: "SELECT * FROM low_rate.`low_rate_input`;"
    syntax: YQL_V1
  }
}

INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:272 Stopped node localhost:23758/1
DEBUG    library.python.filelock:__init__.py:119 Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/27097
DEBUG    library.python.filelock:__init__.py:119 Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/6606
DEBUG    library.python.filelock:__init__.py:119 Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/5619
DEBUG    library.python.filelock:__init__.py:119 Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/23758
DEBUG    library.python.filelock:__init__.py:119 Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/21282
DEBUG    library.python.filelock:__init__.py:119 Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/18081
DEBUG    ya.test:ya.py:181 Binary was found by /home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:264 CFG_DIR_PATH="/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/kikimr_configs"
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:265 Final command: /home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=1 --tenant=/default --node-kind=yq --log-file-name=/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/node_1/logfile_5ohoznhu.log --grpc-port=23758 --mon-port=5619 --ic-port=21282 --module=1
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:264 CFG_DIR_PATH="/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/kikimr_configs"
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:265 Final command: /home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=1 --tenant=/default --node-kind=yq --log-file-name=/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/node_1/logfile_5ohoznhu.log --grpc-port=23758 --mon-port=5619 --ic-port=21282 --module=1
DEBUG    ya.test:process.py:610 Executing '('/home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/kikimr_configs/config.yaml', '--node=1', '--tenant=/default', '--node-kind=yq', '--log-file-name=/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/node_1/logfile_5ohoznhu.log', '--grpc-port=23758', '--mon-port=5619', '--ic-port=21282', '--module=1')' in '/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/node_1' (no wait)
DEBUG    ya.test:process.py:628 Command pid: 1732940
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:305 Started node localhost:23758/1
DEBUG    ya.test:process.py:678 Command out will be placed to ydbd.out.2
DEBUG    ya.test:process.py:678 Command err will be placed to ydbd.err.2
DEBUG    ya.test:process.py:610 Executing '['/home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
DEBUG    ya.test:process.py:628 Command pid: 1732975
DEBUG    ya.test:process.py:259 Command (pid 1732975) rc: 0
DEBUG    ya.test:process.py:260 Command (pid 1732975) elapsed time (sec): 0.4502596855163574
DEBUG    ya.test:process.py:263 Command (pid 1732975) idrss: 0
DEBUG    ya.test:process.py:263 Command (pid 1732975) inblock: 0
DEBUG    ya.test:process.py:263 Command (pid 1732975) isrss: 0
DEBUG    ya.test:process.py:263 Command (pid 1732975) ixrss: 0
DEBUG    ya.test:process.py:263 Command (pid 1732975) majflt: 0
DEBUG    ya.test:process.py:263 Command (pid 1732975) maxrss: 540192
DEBUG    ya.test:process.py:263 Command (pid 1732975) minflt: 16125
DEBUG    ya.test:process.py:263 Command (pid 1732975) msgrcv: 0
DEBUG    ya.test:process.py:263 Command (pid 1732975) msgsnd: 0
DEBUG    ya.test:process.py:263 Command (pid 1732975) nivcsw: 93
DEBUG    ya.test:process.py:263 Command (pid 1732975) nsignals: 0
DEBUG    ya.test:process.py:263 Command (pid 1732975) nswap: 0
DEBUG    ya.test:process.py:263 Command (pid 1732975) nvcsw: 15
DEBUG    ya.test:process.py:263 Command (pid 1732975) oublock: 8
DEBUG    ya.test:process.py:263 Command (pid 1732975) stime: 0.24464
DEBUG    ya.test:process.py:263 Command (pid 1732975) utime: 0.120569
DEBUG    ya.test:process.py:263 Command (pid 1732975) wtime: 0.451
DEBUG    ya.test:process.py:275 Command (pid 1732975) output:
Git info:
    Commit: adb44c074251a1871f952a1fe07a46be1893a61c
    Branch: 
    Author: nfrmtk <nfrmtk.aka.fkfka@gmail.com>
    Summary: Merge 48882a55d21ba4abb146d6a9c2cd1aadf2a909fc into 959c4f93fed7b73b12b83b26b671758583f027f9

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-aathosbtb4
    Host information: 
        Linux ghrun-aathosbtb4 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

    
Build info:
    Compiler: /home/runner/.ya/tools/v4/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -UNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -UNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

DEBUG    ya.test:process.py:276 Command (pid 1732975) errors:

INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:306 Node 1 version:
Git info:
    Commit: adb44c074251a1871f952a1fe07a46be1893a61c
    Branch: 
    Author: nfrmtk <nfrmtk.aka.fkfka@gmail.com>
    Summary: Merge 48882a55d21ba4abb146d6a9c2cd1aadf2a909fc into 959c4f93fed7b73b12b83b26b671758583f027f9
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:527 Cluster started and initialized
DEBUG    root:kikimr_runner.py:283 Wait for node 1 to bootstrap
DEBUG    root:kikimr_runner.py:294 Node 1 has been bootstrapped
DEBUG    ydb.resolver.DiscoveryEndpointsResolver:resolver.py:175 Preparing initial endpoint to resolve endpoints
DEBUG    ydb.connection:connection.py:314 Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
DEBUG    ydb.resolver.DiscoveryEndpointsResolver:resolver.py:185 Resolving endpoints for database local
DEBUG    ydb.connection:connection.py:421 RpcState(ListEndpoints, 018e2913-a269-4f5b-8d1e-c0f26ad0ed19, localhost:27912): creating call state
DEBUG    ydb.connection:connection.py:63 RpcState(ListEndpoints, 018e2913-a269-4f5b-8d1e-c0f26ad0ed19, localhost:27912): request = { database: "local" }
DEBUG    ydb.connection:connection.py:52 RpcState(ListEndpoints, 018e2913-a269-4f5b-8d1e-c0f26ad0ed19, localhost:27912): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-aathosbtb4.auto.internal" port: 27912 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
DEBUG    ydb.resolver.DiscoveryEndpointsResolver:resolver.py:155 Resolved endpoints for database local: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-aathosbtb4.auto.internal:27912, location 1, ssl: False>]>
DEBUG    ydb.connection:connection.py:549 Closing channel for endpoint localhost:27912
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:272 Stopped node localhost:23758/1
DEBUG    ya.test:ya.py:181 Binary was found by /home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:264 CFG_DIR_PATH="/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/kikimr_configs"
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:265 Final command: /home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=1 --tenant=/default --node-kind=yq --log-file-name=/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/node_1/logfile_ti97fuo3.log --grpc-port=23758 --mon-port=5619 --ic-port=21282 --module=1
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:264 CFG_DIR_PATH="/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/kikimr_configs"
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:265 Final command: /home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=1 --tenant=/default --node-kind=yq --log-file-name=/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/node_1/logfile_ti97fuo3.log --grpc-port=23758 --mon-port=5619 --ic-port=21282 --module=1
DEBUG    ya.test:process.py:610 Executing '('/home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/kikimr_configs/config.yaml', '--node=1', '--tenant=/default', '--node-kind=yq', '--log-file-name=/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/node_1/logfile_ti97fuo3.log', '--grpc-port=23758', '--mon-port=5619', '--ic-port=21282', '--module=1')' in '/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/node_1' (no wait)
DEBUG    ya.test:process.py:628 Command pid: 1762474
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:305 Started node localhost:23758/1
DEBUG    ya.test:process.py:678 Command out will be placed to ydbd.out.3
DEBUG    ya.test:process.py:678 Command err will be placed to ydbd.err.3
DEBUG    ya.test:process.py:610 Executing '['/home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
DEBUG    ya.test:process.py:628 Command pid: 1762476
DEBUG    ya.test:process.py:259 Command (pid 1762476) rc: 0
DEBUG    ya.test:process.py:260 Command (pid 1762476) elapsed time (sec): 0.42581820487976074
DEBUG    ya.test:process.py:263 Command (pid 1762476) idrss: 0
DEBUG    ya.test:process.py:263 Command (pid 1762476) inblock: 0
DEBUG    ya.test:process.py:263 Command (pid 1762476) isrss: 0
DEBUG    ya.test:process.py:263 Command (pid 1762476) ixrss: 0
DEBUG    ya.test:process.py:263 Command (pid 1762476) majflt: 0
DEBUG    ya.test:process.py:263 Command (pid 1762476) maxrss: 540192
DEBUG    ya.test:process.py:263 Command (pid 1762476) minflt: 19576
DEBUG    ya.test:process.py:263 Command (pid 1762476) msgrcv: 0
DEBUG    ya.test:process.py:263 Command (pid 1762476) msgsnd: 0
DEBUG    ya.test:process.py:263 Command (pid 1762476) nivcsw: 3
DEBUG    ya.test:process.py:263 Command (pid 1762476) nsignals: 0
DEBUG    ya.test:process.py:263 Command (pid 1762476) nswap: 0
DEBUG    ya.test:process.py:263 Command (pid 1762476) nvcsw: 17
DEBUG    ya.test:process.py:263 Command (pid 1762476) oublock: 8
DEBUG    ya.test:process.py:263 Command (pid 1762476) stime: 0.265227
DEBUG    ya.test:process.py:263 Command (pid 1762476) utime: 0.11252
DEBUG    ya.test:process.py:263 Command (pid 1762476) wtime: 0.427
DEBUG    ya.test:process.py:275 Command (pid 1762476) output:
Git info:
    Commit: adb44c074251a1871f952a1fe07a46be1893a61c
    Branch: 
    Author: nfrmtk <nfrmtk.aka.fkfka@gmail.com>
    Summary: Merge 48882a55d21ba4abb146d6a9c2cd1aadf2a909fc into 959c4f93fed7b73b12b83b26b671758583f027f9

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-aathosbtb4
    Host information: 
        Linux ghrun-aathosbtb4 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

    
Build info:
    Compiler: /home/runner/.ya/tools/v4/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -UNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -UNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

DEBUG    ya.test:process.py:276 Command (pid 1762476) errors:

INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:306 Node 1 version:
Git info:
    Commit: adb44c074251a1871f952a1fe07a46be1893a61c
    Branch: 
    Author: nfrmtk <nfrmtk.aka.fkfka@gmail.com>
    Summary: Merge 48882a55d21ba4abb146d6a9c2cd1aadf2a909fc into 959c4f93fed7b73b12b83b26b671758583f027f9
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:527 Cluster started and initialized
DEBUG    root:kikimr_runner.py:283 Wait for node 1 to bootstrap
DEBUG    ydb.resolver.DiscoveryEndpointsResolver:resolver.py:175 Preparing initial endpoint to resolve endpoints
DEBUG    ydb.connection:connection.py:314 Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
DEBUG    ydb.resolver.DiscoveryEndpointsResolver:resolver.py:185 Resolving endpoints for database local
DEBUG    ydb.connection:connection.py:421 RpcState(ListEndpoints, 233a8524-bb63-4770-8929-8053c4c713cf, localhost:27912): creating call state
DEBUG    ydb.connection:connection.py:63 RpcState(ListEndpoints, 233a8524-bb63-4770-8929-8053c4c713cf, localhost:27912): request = { database: "local" }
DEBUG    ydb.connection:connection.py:52 RpcState(ListEndpoints, 233a8524-bb63-4770-8929-8053c4c713cf, localhost:27912): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-aathosbtb4.auto.internal" port: 27912 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
DEBUG    ydb.resolver.DiscoveryEndpointsResolver:resolver.py:155 Resolved endpoints for database local: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-aathosbtb4.auto.internal:27912, location 1, ssl: False>]>
DEBUG    ydb.connection:connection.py:549 Closing channel for endpoint localhost:27912
DEBUG    ydb.resolver.DiscoveryEndpointsResolver:resolver.py:175 Preparing initial endpoint to resolve endpoints
DEBUG    ydb.connection:connection.py:314 Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
DEBUG    ydb.resolver.DiscoveryEndpointsResolver:resolver.py:185 Resolving endpoints for database local
DEBUG    ydb.connection:connection.py:421 RpcState(ListEndpoints, e4109b4a-847c-41b1-bc60-bee305a71ab6, localhost:27912): creating call state
DEBUG    ydb.connection:connection.py:63 RpcState(ListEndpoints, e4109b4a-847c-41b1-bc60-bee305a71ab6, localhost:27912): request = { database: "local" }
DEBUG    ydb.connection:connection.py:52 RpcState(ListEndpoints, e4109b4a-847c-41b1-bc60-bee305a71ab6, localhost:27912): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-aathosbtb4.auto.internal" port: 27912 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
DEBUG    ydb.resolver.DiscoveryEndpointsResolver:resolver.py:155 Resolved endpoints for database local: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-aathosbtb4.auto.internal:27912, location 1, ssl: False>]>
DEBUG    ydb.connection:connection.py:549 Closing channel for endpoint localhost:27912
---------------------------- Captured log teardown -----------------------------
INFO     ya.test:ya.py:431 Test teardown
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:272 Stopped node localhost:23758/1
=================================== FAILURES ===================================
_______________________ TestRetry.test_low_rate[kikimr0] _______________________
ydb/tests/fq/multi_plane/test_retry.py:98: in test_low_rate
    kikimr.compute_plane.wait_bootstrap()
ydb/tests/tools/fq_runner/kikimr_runner.py:280: in wait_bootstrap
    self.wait_bootstrap(n, wait_time)
ydb/tests/tools/fq_runner/kikimr_runner.py:285: in wait_bootstrap
    assert time.time() < deadline, "Node {} bootstrap deadline {}s exceeded".format(node_index, wait_time)
E   AssertionError: Node 1 bootstrap deadline 90s exceeded
------------------------------ Captured log setup ------------------------------
INFO     ya.test:ya.py:420 ####################################################################################################
INFO     ya.test:ya.py:421 test_low_rate[kikimr0]
INFO     ya.test:ya.py:422 ####################################################################################################
INFO     ya.test:ya.py:423 Test setup
DEBUG    library.python.filelock:__init__.py:115 Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/26960
DEBUG    library.python.filelock:__init__.py:115 Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18081
DEBUG    ya.test:ya.py:181 Binary was found by /home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd
DEBUG    library.python.filelock:__init__.py:115 Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/21282
DEBUG    library.python.filelock:__init__.py:115 Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/23758
DEBUG    ydb.connection:connection.py:314 Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
DEBUG    ydb.resolver.DiscoveryEndpointsResolver:resolver.py:175 Preparing initial endpoint to resolve endpoints
DEBUG    ydb.connection:connection.py:314 Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
DEBUG    ydb.resolver.DiscoveryEndpointsResolver:resolver.py:185 Resolving endpoints for database local
DEBUG    ydb.connection:connection.py:421 RpcState(ListEndpoints, 7396c8a0-3611-424d-9d25-8c79570e815c, localhost:27912): creating call state
DEBUG    ydb.connection:connection.py:63 RpcState(ListEndpoints, 7396c8a0-3611-424d-9d25-8c79570e815c, localhost:27912): request = { database: "local" }
DEBUG    ydb.connection:connection.py:52 RpcState(ListEndpoints, 7396c8a0-3611-424d-9d25-8c79570e815c, localhost:27912): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-aathosbtb4.auto.internal" port: 27912 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
DEBUG    ydb.resolver.DiscoveryEndpointsResolver:resolver.py:155 Resolved endpoints for database local: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-aathosbtb4.auto.internal:27912, location 1, ssl: False>]>
DEBUG    ydb.connection:connection.py:314 Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
DEBUG    ydb.connection:connection.py:549 Closing channel for endpoint localhost:27912
DEBUG    ydb.table.SessionPool:_sp_impl.py:260 Active session queue is empty, subscribe waiter for a session
DEBUG    ydb.table.SessionPool:_sp_impl.py:262 Subscribe waiter <Future at 0x7ff34d6d08d0 state=pending>
DEBUG    ydb.table.SessionPool:_sp_impl.py:282 Session pool is not large enough (active_count < size: 0 < 1). will create a new session.
DEBUG    ydb.table.SessionPool:_sp_impl.py:111 Created session <ydb.table.Session object at 0x7ff34d6d3210>
DEBUG    ydb.table.SessionPool:_sp_impl.py:238 Preparing session <ydb.table.Session object at 0x7ff34d6d3210>
DEBUG    ydb.connection:connection.py:421 RpcState(CreateSession, f6408774-4a9b-4933-bdbd-beed0926b1de, ghrun-aathosbtb4.auto.internal:27912): creating call state
DEBUG    ydb.connection:connection.py:63 RpcState(CreateSession, f6408774-4a9b-4933-bdbd-beed0926b1de, ghrun-aathosbtb4.auto.internal:27912): request = { operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
DEBUG    ydb.connection:connection.py:118 RpcState(CreateSession, f6408774-4a9b-4933-bdbd-beed0926b1de, ghrun-aathosbtb4.auto.internal:27912): on response callback started
DEBUG    ydb.connection:connection.py:52 RpcState(CreateSession, f6408774-4a9b-4933-bdbd-beed0926b1de, ghrun-aathosbtb4.auto.internal:27912): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=M2VhNDc0OTItNGVhOWYxNGUtZWJmNzc4NWMtNTI3NjVkMTU=" } } } }
DEBUG    ydb.connection:connection.py:123 RpcState(CreateSession, f6408774-4a9b-4933-bdbd-beed0926b1de, ghrun-aathosbtb4.auto.internal:27912): on response callback success
DEBUG    ydb.table.SessionPool:_sp_impl.py:177 Put on session <ydb.table.Session object at 0x7ff34d6d3210>
DEBUG    ydb.table.SessionPool:_sp_impl.py:195 Replying to waiter with a session <ydb.table.Session object at 0x7ff34d6d3210>
DEBUG    ydb.connection:connection.py:421 RpcState(CreateTable, 00759c3f-af6e-4129-8f82-f37fd287f928, ghrun-aathosbtb4.auto.internal:27912): creating call state
DEBUG    ydb.connection:connection.py:63 RpcState(CreateTable, 00759c3f-af6e-4129-8f82-f37fd287f928, ghrun-aathosbtb4.auto.internal:27912): request = { session_id: "ydb://session/3?node_id=1&id=M2VhNDc0OTItNGVhOWYxNGUtZWJmNzc4NWMtNTI3NjVkMTU=" path: "local/DbPoolStorage_cb360dc2-0778-4f13-83c6-b7a0787a95fc/tenants" columns { name: "tenant" type { optional_type { item { type_id: STRING } } } } columns { name: "vtenant" type { optional_type { item { type_id: STRING } } } } columns { name: "common" type { optional_type { item { type_id: BOOL } } } } columns { name: "state" type { optional_type { item { type_id: UINT32 } } } } columns { name: "state_time" type { optional_type { item { type_id: TIMESTAMP } } } } primary_key: "tenant" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
DEBUG    ydb.connection:connection.py:52 RpcState(CreateTable, 00759c3f-af6e-4129-8f82-f37fd287f928, ghrun-aathosbtb4.auto.internal:27912): response = { operation { ready: true status: SUCCESS } }
DEBUG    ydb.table.SessionPool:_sp_impl.py:177 Put on session <ydb.table.Session object at 0x7ff34d6d3210>
DEBUG    ydb.connection:connection.py:421 RpcState(CreateTable, 5f88affd-5538-467d-bd90-1fd5646e03af, ghrun-aathosbtb4.auto.internal:27912): creating call state
DEBUG    ydb.connection:connection.py:63 RpcState(CreateTable, 5f88affd-5538-467d-bd90-1fd5646e03af, ghrun-aathosbtb4.auto.internal:27912): request = { session_id: "ydb://session/3?node_id=1&id=M2VhNDc0OTItNGVhOWYxNGUtZWJmNzc4NWMtNTI3NjVkMTU=" path: "local/DbPoolStorage_cb360dc2-0778-4f13-83c6-b7a0787a95fc/mappings" columns { name: "subject_type" type { optional_type { item { type_id: STRING } } } } columns { name: "subject_id" type { optional_type { item { type_id: STRING } } } } columns { name: "vtenant" type { optional_type { item { type_id: STRING } } } } columns { name: "node" type { optional_type { item { type_id: STRING } } } } primary_key: "subject_type" primary_key: "subject_id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
DEBUG    ydb.connection:connection.py:52 RpcState(CreateTable, 5f88affd-5538-467d-bd90-1fd5646e03af, ghrun-aathosbtb4.auto.internal:27912): response = { operation { ready: true status: SUCCESS } }
DEBUG    ydb.table.SessionPool:_sp_impl.py:177 Put on session <ydb.table.Session object at 0x7ff34d6d3210>
DEBUG    ydb.connection:connection.py:421 RpcState(ExecuteDataQuery, 3e4f5cfa-a28e-49c0-9b42-8ec2dc59847b, ghrun-aathosbtb4.auto.internal:27912): creating call state
DEBUG    ydb.connection:connection.py:63 RpcState(ExecuteDataQuery, 3e4f5cfa-a28e-49c0-9b42-8ec2dc59847b, ghrun-aathosbtb4.auto.internal:27912): request = { session_id: "ydb://session/3?node_id=1&id=M2VhNDc0OTItNGVhOWYxNGUtZWJmNzc4NWMtNTI3NjVkMTU=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "--!syntax_v1\n            PRAGMA TablePathPrefix(\"local/DbPoolStorage_cb360dc2-0778-4f13-83c6-b7a0787a95fc\");\n            UPSERT INTO tenants (tenant, vtenant, common, state, state_time) values(\"/default\", \"/default\", true, 0, CurrentUtcTimestamp());\n                " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
DEBUG    ydb.connection:connection.py:52 RpcState(ExecuteDataQuery, 3e4f5cfa-a28e-49c0-9b42-8ec2dc59847b, ghrun-aathosbtb4.auto.internal:27912): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
DEBUG    ydb.table.SessionPool:_sp_impl.py:177 Put on session <ydb.table.Session object at 0x7ff34d6d3210>
DEBUG    ya.test:ya.py:181 Binary was found by /home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd
DEBUG    library.python.filelock:__init__.py:115 Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/5619
DEBUG    library.python.filelock:__init__.py:115 Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/6606
DEBUG    library.python.filelock:__init__.py:115 Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/27097
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:264 CFG_DIR_PATH="/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/kikimr_configs"
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:265 Final command: /home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=1 --tenant=/default --node-kind=yq --log-file-name=/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/node_1/logfile_u4wkaukr.log --grpc-port=23758 --mon-port=5619 --ic-port=21282 --module=1
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:264 CFG_DIR_PATH="/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/kikimr_configs"
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:265 Final command: /home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=1 --tenant=/default --node-kind=yq --log-file-name=/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/node_1/logfile_u4wkaukr.log --grpc-port=23758 --mon-port=5619 --ic-port=21282 --module=1
DEBUG    ya.test:process.py:610 Executing '('/home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/kikimr_configs/config.yaml', '--node=1', '--tenant=/default', '--node-kind=yq', '--log-file-name=/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/node_1/logfile_u4wkaukr.log', '--grpc-port=23758', '--mon-port=5619', '--ic-port=21282', '--module=1')' in '/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/node_1' (no wait)
DEBUG    ya.test:process.py:628 Command pid: 1717436
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:305 Started node localhost:23758/1
DEBUG    ya.test:process.py:678 Command out will be placed to ydbd.out.1
DEBUG    ya.test:process.py:678 Command err will be placed to ydbd.err.1
DEBUG    ya.test:process.py:610 Executing '['/home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
DEBUG    ya.test:process.py:628 Command pid: 1717482
DEBUG    ya.test:process.py:259 Command (pid 1717482) rc: 0
DEBUG    ya.test:process.py:260 Command (pid 1717482) elapsed time (sec): 0.9586708545684814
DEBUG    ya.test:process.py:263 Command (pid 1717482) idrss: 0
DEBUG    ya.test:process.py:263 Command (pid 1717482) inblock: 0
DEBUG    ya.test:process.py:263 Command (pid 1717482) isrss: 0
DEBUG    ya.test:process.py:263 Command (pid 1717482) ixrss: 0
DEBUG    ya.test:process.py:263 Command (pid 1717482) majflt: 0
DEBUG    ya.test:process.py:263 Command (pid 1717482) maxrss: 540192
DEBUG    ya.test:process.py:263 Command (pid 1717482) minflt: 16126
DEBUG    ya.test:process.py:263 Command (pid 1717482) msgrcv: 0
DEBUG    ya.test:process.py:263 Command (pid 1717482) msgsnd: 0
DEBUG    ya.test:process.py:263 Command (pid 1717482) nivcsw: 179
DEBUG    ya.test:process.py:263 Command (pid 1717482) nsignals: 0
DEBUG    ya.test:process.py:263 Command (pid 1717482) nswap: 0
DEBUG    ya.test:process.py:263 Command (pid 1717482) nvcsw: 18
DEBUG    ya.test:process.py:263 Command (pid 1717482) oublock: 8
DEBUG    ya.test:process.py:263 Command (pid 1717482) stime: 0.746468
DEBUG    ya.test:process.py:263 Command (pid 1717482) utime: 0.127327
DEBUG    ya.test:process.py:263 Command (pid 1717482) wtime: 0.966
DEBUG    ya.test:process.py:275 Command (pid 1717482) output:
Git info:
    Commit: adb44c074251a1871f952a1fe07a46be1893a61c
    Branch: 
    Author: nfrmtk <nfrmtk.aka.fkfka@gmail.com>
    Summary: Merge 48882a55d21ba4abb146d6a9c2cd1aadf2a909fc into 959c4f93fed7b73b12b83b26b671758583f027f9

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-aathosbtb4
    Host information: 
        Linux ghrun-aathosbtb4 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

    
Build info:
    Compiler: /home/runner/.ya/tools/v4/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -UNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -UNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

DEBUG    ya.test:process.py:276 Command (pid 1717482) errors:

INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:306 Node 1 version:
Git info:
    Commit: adb44c074251a1871f952a1fe07a46be1893a61c
    Branch: 
    Author: nfrmtk <nfrmtk.aka.fkfka@gmail.com>
    Summary: Merge 48882a55d21ba4abb146d6a9c2cd1aadf2a909fc into 959c4f93fed7b73b12b83b26b671758583f027f9
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:527 Cluster started and initialized
------------------------------ Captured log call -------------------------------
INFO     ya.test:ya.py:436 Test call (class_name: test_retry.py::TestRetry, test_name: test_low_rate[kikimr0])
DEBUG    root:control_plane.py:61 Requesting CreateStream.
Database: "local".
Request:
stream_name: "/local/low_rate_input"
shard_count: 1
write_quota_kb_per_sec: 1024
retention_period_hours: 1

DEBUG    root:control_plane.py:45 Response: operation {
  ready: true
  status: SUCCESS
}

DEBUG    root:control_plane.py:49 Result: 
DEBUG    root:control_plane.py:61 Requesting CreateStream.
Database: "local".
Request:
stream_name: "/local/low_rate_output"
shard_count: 1
write_quota_kb_per_sec: 1024
retention_period_hours: 1

DEBUG    root:control_plane.py:45 Response: operation {
  ready: true
  status: SUCCESS
}

DEBUG    root:control_plane.py:49 Result: 
DEBUG    root:control_plane.py:45 Response: operation {
  ready: true
  status: SUCCESS
}

DEBUG    root:control_plane.py:49 Result: 
DEBUG    root:fq_client.py:170 Request: content {
  type: STREAMING
  name: "a"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "SELECT * FROM low_rate.`low_rate_input`;"
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "1d999e03-37a5-44ff-9392-86babf8c4dcc"

DEBUG    root:fq_client.py:180 Result: query_id: "ptqudts2o4ptk3uvqt9p"

DEBUG    root:fq_client.py:284 Result: query {
  meta {
    common {
      id: "ptqudts2o4ptk3uvqt9p"
      created_by: "root@builtin"
      modified_by: "root@builtin"
      created_at {
        seconds: 1761552108
        nanos: 816662000
      }
      modified_at {
        seconds: 1761552108
        nanos: 816662000
      }
      revision: 1
    }
    execute_mode: RUN
    status: STARTING
    last_job_query_revision: 1
    last_job_id: "ptjudts2o4ptjuvf6no8-ptqudts2o4ptk3uvqt9p"
    started_by: "root@builtin"
    submitted_at {
      seconds: 1761552108
      nanos: 816662000
    }
  }
  content {
    type: STREAMING
    name: "a"
    acl {
      visibility: PRIVATE
    }
    limits {
      execution_timeout {
      }
    }
    text: "SELECT * FROM low_rate.`low_rate_input`;"
    syntax: YQL_V1
  }
}

DEBUG    root:fq_client.py:284 Result: query {
  meta {
    common {
      id: "ptqudts2o4ptk3uvqt9p"
      created_by: "root@builtin"
      modified_by: "root@builtin"
      created_at {
        seconds: 1761552108
        nanos: 816662000
      }
      modified_at {
        seconds: 1761552108
        nanos: 816662000
      }
      revision: 1
    }
    started_at {
      seconds: 1761552109
      nanos: 340000000
    }
    execute_mode: RUN
    status: RUNNING
    last_job_query_revision: 1
    last_job_id: "ptjudts2o4ptjuvf6no8-ptqudts2o4ptk3uvqt9p"
    started_by: "root@builtin"
    submitted_at {
      seconds: 1761552108
      nanos: 816662000
    }
  }
  content {
    type: STREAMING
    name: "a"
    acl {
      visibility: PRIVATE
    }
    limits {
      execution_timeout {
      }
    }
    text: "SELECT * FROM low_rate.`low_rate_input`;"
    syntax: YQL_V1
  }
}

INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:272 Stopped node localhost:23758/1
DEBUG    library.python.filelock:__init__.py:119 Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/27097
DEBUG    library.python.filelock:__init__.py:119 Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/6606
DEBUG    library.python.filelock:__init__.py:119 Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/5619
DEBUG    library.python.filelock:__init__.py:119 Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/23758
DEBUG    library.python.filelock:__init__.py:119 Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/21282
DEBUG    library.python.filelock:__init__.py:119 Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/18081
DEBUG    ya.test:ya.py:181 Binary was found by /home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:264 CFG_DIR_PATH="/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/kikimr_configs"
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:265 Final command: /home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=1 --tenant=/default --node-kind=yq --log-file-name=/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/node_1/logfile_5ohoznhu.log --grpc-port=23758 --mon-port=5619 --ic-port=21282 --module=1
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:264 CFG_DIR_PATH="/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/kikimr_configs"
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:265 Final command: /home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=1 --tenant=/default --node-kind=yq --log-file-name=/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/node_1/logfile_5ohoznhu.log --grpc-port=23758 --mon-port=5619 --ic-port=21282 --module=1
DEBUG    ya.test:process.py:610 Executing '('/home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/kikimr_configs/config.yaml', '--node=1', '--tenant=/default', '--node-kind=yq', '--log-file-name=/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/node_1/logfile_5ohoznhu.log', '--grpc-port=23758', '--mon-port=5619', '--ic-port=21282', '--module=1')' in '/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/node_1' (no wait)
DEBUG    ya.test:process.py:628 Command pid: 1732940
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:305 Started node localhost:23758/1
DEBUG    ya.test:process.py:678 Command out will be placed to ydbd.out.2
DEBUG    ya.test:process.py:678 Command err will be placed to ydbd.err.2
DEBUG    ya.test:process.py:610 Executing '['/home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
DEBUG    ya.test:process.py:628 Command pid: 1732975
DEBUG    ya.test:process.py:259 Command (pid 1732975) rc: 0
DEBUG    ya.test:process.py:260 Command (pid 1732975) elapsed time (sec): 0.4502596855163574
DEBUG    ya.test:process.py:263 Command (pid 1732975) idrss: 0
DEBUG    ya.test:process.py:263 Command (pid 1732975) inblock: 0
DEBUG    ya.test:process.py:263 Command (pid 1732975) isrss: 0
DEBUG    ya.test:process.py:263 Command (pid 1732975) ixrss: 0
DEBUG    ya.test:process.py:263 Command (pid 1732975) majflt: 0
DEBUG    ya.test:process.py:263 Command (pid 1732975) maxrss: 540192
DEBUG    ya.test:process.py:263 Command (pid 1732975) minflt: 16125
DEBUG    ya.test:process.py:263 Command (pid 1732975) msgrcv: 0
DEBUG    ya.test:process.py:263 Command (pid 1732975) msgsnd: 0
DEBUG    ya.test:process.py:263 Command (pid 1732975) nivcsw: 93
DEBUG    ya.test:process.py:263 Command (pid 1732975) nsignals: 0
DEBUG    ya.test:process.py:263 Command (pid 1732975) nswap: 0
DEBUG    ya.test:process.py:263 Command (pid 1732975) nvcsw: 15
DEBUG    ya.test:process.py:263 Command (pid 1732975) oublock: 8
DEBUG    ya.test:process.py:263 Command (pid 1732975) stime: 0.24464
DEBUG    ya.test:process.py:263 Command (pid 1732975) utime: 0.120569
DEBUG    ya.test:process.py:263 Command (pid 1732975) wtime: 0.451
DEBUG    ya.test:process.py:275 Command (pid 1732975) output:
Git info:
    Commit: adb44c074251a1871f952a1fe07a46be1893a61c
    Branch: 
    Author: nfrmtk <nfrmtk.aka.fkfka@gmail.com>
    Summary: Merge 48882a55d21ba4abb146d6a9c2cd1aadf2a909fc into 959c4f93fed7b73b12b83b26b671758583f027f9

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-aathosbtb4
    Host information: 
        Linux ghrun-aathosbtb4 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

    
Build info:
    Compiler: /home/runner/.ya/tools/v4/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -UNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -UNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

DEBUG    ya.test:process.py:276 Command (pid 1732975) errors:

INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:306 Node 1 version:
Git info:
    Commit: adb44c074251a1871f952a1fe07a46be1893a61c
    Branch: 
    Author: nfrmtk <nfrmtk.aka.fkfka@gmail.com>
    Summary: Merge 48882a55d21ba4abb146d6a9c2cd1aadf2a909fc into 959c4f93fed7b73b12b83b26b671758583f027f9
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:527 Cluster started and initialized
DEBUG    root:kikimr_runner.py:283 Wait for node 1 to bootstrap
DEBUG    root:kikimr_runner.py:294 Node 1 has been bootstrapped
DEBUG    ydb.resolver.DiscoveryEndpointsResolver:resolver.py:175 Preparing initial endpoint to resolve endpoints
DEBUG    ydb.connection:connection.py:314 Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
DEBUG    ydb.resolver.DiscoveryEndpointsResolver:resolver.py:185 Resolving endpoints for database local
DEBUG    ydb.connection:connection.py:421 RpcState(ListEndpoints, 018e2913-a269-4f5b-8d1e-c0f26ad0ed19, localhost:27912): creating call state
DEBUG    ydb.connection:connection.py:63 RpcState(ListEndpoints, 018e2913-a269-4f5b-8d1e-c0f26ad0ed19, localhost:27912): request = { database: "local" }
DEBUG    ydb.connection:connection.py:52 RpcState(ListEndpoints, 018e2913-a269-4f5b-8d1e-c0f26ad0ed19, localhost:27912): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-aathosbtb4.auto.internal" port: 27912 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
DEBUG    ydb.resolver.DiscoveryEndpointsResolver:resolver.py:155 Resolved endpoints for database local: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-aathosbtb4.auto.internal:27912, location 1, ssl: False>]>
DEBUG    ydb.connection:connection.py:549 Closing channel for endpoint localhost:27912
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:272 Stopped node localhost:23758/1
DEBUG    ya.test:ya.py:181 Binary was found by /home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:264 CFG_DIR_PATH="/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/kikimr_configs"
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:265 Final command: /home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=1 --tenant=/default --node-kind=yq --log-file-name=/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/node_1/logfile_ti97fuo3.log --grpc-port=23758 --mon-port=5619 --ic-port=21282 --module=1
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:264 CFG_DIR_PATH="/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/kikimr_configs"
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:265 Final command: /home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=1 --tenant=/default --node-kind=yq --log-file-name=/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/node_1/logfile_ti97fuo3.log --grpc-port=23758 --mon-port=5619 --ic-port=21282 --module=1
DEBUG    ya.test:process.py:610 Executing '('/home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/kikimr_configs/config.yaml', '--node=1', '--tenant=/default', '--node-kind=yq', '--log-file-name=/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/node_1/logfile_ti97fuo3.log', '--grpc-port=23758', '--mon-port=5619', '--ic-port=21282', '--module=1')' in '/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/node_1' (no wait)
DEBUG    ya.test:process.py:628 Command pid: 1762474
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:305 Started node localhost:23758/1
DEBUG    ya.test:process.py:678 Command out will be placed to ydbd.out.3
DEBUG    ya.test:process.py:678 Command err will be placed to ydbd.err.3
DEBUG    ya.test:process.py:610 Executing '['/home/runner/.ya/build/build_root/dyq9/002679/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
DEBUG    ya.test:process.py:628 Command pid: 1762476
DEBUG    ya.test:process.py:259 Command (pid 1762476) rc: 0
DEBUG    ya.test:process.py:260 Command (pid 1762476) elapsed time (sec): 0.42581820487976074
DEBUG    ya.test:process.py:263 Command (pid 1762476) idrss: 0
DEBUG    ya.test:process.py:263 Command (pid 1762476) inblock: 0
DEBUG    ya.test:process.py:263 Command (pid 1762476) isrss: 0
DEBUG    ya.test:process.py:263 Command (pid 1762476) ixrss: 0
DEBUG    ya.test:process.py:263 Command (pid 1762476) majflt: 0
DEBUG    ya.test:process.py:263 Command (pid 1762476) maxrss: 540192
DEBUG    ya.test:process.py:263 Command (pid 1762476) minflt: 19576
DEBUG    ya.test:process.py:263 Command (pid 1762476) msgrcv: 0
DEBUG    ya.test:process.py:263 Command (pid 1762476) msgsnd: 0
DEBUG    ya.test:process.py:263 Command (pid 1762476) nivcsw: 3
DEBUG    ya.test:process.py:263 Command (pid 1762476) nsignals: 0
DEBUG    ya.test:process.py:263 Command (pid 1762476) nswap: 0
DEBUG    ya.test:process.py:263 Command (pid 1762476) nvcsw: 17
DEBUG    ya.test:process.py:263 Command (pid 1762476) oublock: 8
DEBUG    ya.test:process.py:263 Command (pid 1762476) stime: 0.265227
DEBUG    ya.test:process.py:263 Command (pid 1762476) utime: 0.11252
DEBUG    ya.test:process.py:263 Command (pid 1762476) wtime: 0.427
DEBUG    ya.test:process.py:275 Command (pid 1762476) output:
Git info:
    Commit: adb44c074251a1871f952a1fe07a46be1893a61c
    Branch: 
    Author: nfrmtk <nfrmtk.aka.fkfka@gmail.com>
    Summary: Merge 48882a55d21ba4abb146d6a9c2cd1aadf2a909fc into 959c4f93fed7b73b12b83b26b671758583f027f9

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-aathosbtb4
    Host information: 
        Linux ghrun-aathosbtb4 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

    
Build info:
    Compiler: /home/runner/.ya/tools/v4/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -UNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -UNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

DEBUG    ya.test:process.py:276 Command (pid 1762476) errors:

INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:306 Node 1 version:
Git info:
    Commit: adb44c074251a1871f952a1fe07a46be1893a61c
    Branch: 
    Author: nfrmtk <nfrmtk.aka.fkfka@gmail.com>
    Summary: Merge 48882a55d21ba4abb146d6a9c2cd1aadf2a909fc into 959c4f93fed7b73b12b83b26b671758583f027f9
INFO     ydb.tests.library.harness.kikimr_runner:kikimr_runner.py:527 Cluster started and initialized
DEBUG    root:kikimr_runner.py:283 Wait for node 1 to bootstrap
DEBUG    ydb.resolver.DiscoveryEndpointsResolver:resolver.py:175 Preparing initial endpoint to resolve endpoints
DEBUG    ydb.connection:connection.py:314 Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
DEBUG    ydb.resolver.DiscoveryEndpointsResolver:resolver.py:185 Resolving endpoints for database local
DEBUG    ydb.connection:connection.py:421 RpcState(ListEndpoints, 233a8524-bb63-4770-8929-8053c4c713cf, localhost:27912): creating call state
DEBUG    ydb.connection:connection.py:63 RpcState(ListEndpoints, 233a8524-bb63-4770-8929-8053c4c713cf, localhost:27912): request = { database: "local" }
DEBUG    ydb.connection:connection.py:52 RpcState(ListEndpoints, 233a8524-bb63-4770-8929-8053c4c713cf, localhost:27912): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-aathosbtb4.auto.internal" port: 27912 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
DEBUG    ydb.resolver.DiscoveryEndpointsResolver:resolver.py:155 Resolved endpoints for database local: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-aathosbtb4.auto.internal:27912, location 1, ssl: False>]>
DEBUG    ydb.connection:connection.py:549 Closing channel for endpoint localhost:27912
DEBUG    ydb.resolver.DiscoveryEndpointsResolver:resolver.py:175 Preparing initial endpoint to resolve endpoints
DEBUG    ydb.connection:connection.py:314 Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
DEBUG    ydb.resolver.DiscoveryEndpointsResolver:resolver.py:185 Resolving endpoints for database local
DEBUG    ydb.connection:connection.py:421 RpcState(ListEndpoints, e4109b4a-847c-41b1-bc60-bee305a71ab6, localhost:27912): creating call state
DEBUG    ydb.connection:connection.py:63 RpcState(ListEndpoints, e4109b4a-847c-41b1-bc60-bee305a71ab6, localhost:27912): request = { database: "local" }
DEBUG    ydb.connection:connection.py:52 RpcState(ListEndpoints, e4109b4a-847c-41b1-bc60-bee305a71ab6, localhost:27912): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-aathosbtb4.auto.internal" port: 27912 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
DEBUG    ydb.resolver.DiscoveryEndpointsResolver:resolver.py:155 Resolved endpoints for database local: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-aathosbtb4.auto.internal:27912, location 1, ssl: False>]>
DEBUG    ydb.connection:connection.py:549 Closing channel for endpoint localhost:27912
============================== slowest durations ===============================
151.01s call     test_retry.py::TestRetry::test_low_rate[kikimr0]
19.03s call     test_retry.py::TestRetry::test_fail_first[kikimr0]
1.35s setup    test_retry.py::TestRetry::test_low_rate[kikimr0]
1.15s setup    test_retry.py::TestRetry::test_fail_first[kikimr0]
1.00s teardown test_retry.py::TestRetry::test_fail_first[kikimr0]

(1 durations < 0.005s hidden.  Use -vv to show these durations.)
=========================== short test summary info ============================
FAILED test_retry.py::TestRetry::test_low_rate[kikimr0] - AssertionError: Node 1 bootstrap deadline 90s exceeded
ERROR test_retry.py::TestRetry::test_low_rate[kikimr0] - ydb.tests.library.harness.daemon.SeveralDaemonErrors: Daemon failed with message: Unexpectedly finished before stop.
Process exit_code = 1.
Stdout file name: 
/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/node_1/stdout
Stderr file name: 
/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff/test_retry.py.TestRetry.test_low_rate.kikimr0/default/node_1/stderr
Stderr content:

GRpc memory quota was set but disabled due to issues with grpc quoter, to enable it use EnableGRpcMemoryQuota option
GRpc memory quota was set but disabled due to issues with grpc quoter, to enable it use EnableGRpcMemoryQuota option
GRpc shutdown warning: left infly: 1, spent: 3.287737 sec. GRpcShutdownDeadline: 30
GRpc shutdown warning: left infly: 1, spent: 6.533646 sec. GRpcShutdownDeadline: 30
GRpc shutdown warning: left infly: 1, spent: 9.669783 sec. GRpcShutdownDeadline: 30
GRpc shutdown warning: left infly: 1, spent: 12.77468 sec. GRpcShutdownDeadline: 30
GRpc shutdown warning: left infly: 1, spent: 15.911675 sec. GRpcShutdownDeadline: 30
GRpc shutdown warning: left infly: 1, spent: 19.038655 sec. GRpcShutdownDeadline: 30
GRpc shutdown warning: left infly: 1, spent: 22.132918 sec. GRpcShutdownDeadline: 30
GRpc shutdown warning: left infly: 1, spent: 25.229911 sec. GRpcShutdownDeadline: 30
GRpc shutdown warning: left infly: 1, spent: 28.310882 sec. GRpcShutdownDeadline: 30
GRpc shutdown warning: failed to shutdown all connections, left infly: 1, spent: 30.006847 sec. GRpcShutdownDeadline: 30
Caught exception: ydb/core/driver_lib/run/kikimr_services_initializers.cpp:850: Failed to set up IC listener on port 21282 errno# 98 (Address already in use)
=============== 1 failed, 1 passed, 1 error in 174.42s (0:02:54) ===============

Traceback (most recent call last):
  File "library/python/testing/yatest_common/yatest/common/process.py", line 384, in wait
    wait_for(
  File "library/python/testing/yatest_common/yatest/common/process.py", line 765, in wait_for
    raise TimeoutError(truncate(message, MAX_MESSAGE_LEN))
yatest.common.process.TimeoutError: ...d/build_root/dyq9/002679/ydb/tests/fq/multi_plane/ydb-tests-fq-multi_plane', '--basetemp', '/home/runner/.ya/build/build_root/dyq9/002679/tmp', '--capture', 'no', '-c', 'pkg:library.python.pytest:pytest.yatest.ini', '-p', 'no:factor', '--doctest-modules', '--ya-trace', '/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/ytest.report.trace', '--build-root', '/home/runner/.ya/build/build_root/dyq9/002679', '--source-root', '/home/runner/.ya/build/build_root/dyq9/002679/environment/arcadia', '--output-dir', '/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff', '--durations', '0', '--project-path', 'ydb/tests/fq/multi_plane', '--test-tool-bin', '/home/runner/.ya/tools/v4/9985353571/test_tool', '--ya-version', '2', '--collect-cores', '--build-type', 'relwithdebinfo', '--tb', 'short', '--dep-root', 'ydb/tests/fq/multi_plane', '--flags', 'APPLE_SDK_LOCAL=yes', '--flags', 'CFLAGS=-fno-omit-frame-pointer -Wno-unknown-argument', '--flags', 'DEBUGINFO_LINES_ONLY=yes', '--flags', 'DISABLE_FLAKE8_MIGRATIONS=yes', '--flags', 'OPENSOURCE=yes', '--flags', 'TESTS_REQUESTED=yes', '--flags', 'USE_AIO=static', '--flags', 'USE_CLANG_CL=yes', '--flags', 'USE_EAT_MY_DATA=yes', '--flags', 'USE_ICONV=static', '--flags', 'USE_IDN=static', '--flags', 'USE_PREBUILT_TOOLS=no', '--test-file-filter', 'test_retry.py']' stopped by 600 seconds timeout

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "devtools/ya/test/programs/test_tool/run_test/run_test.py", line 1770, in main
    res.wait(check_exit_code=False, timeout=current_run_test_timeout, on_timeout=timeout_callback)
  File "library/python/testing/yatest_common/yatest/common/process.py", line 398, in wait
    raise ExecutionTimeoutError(self, str(e))
yatest.common.process.ExecutionTimeoutError: (("...d/build_root/dyq9/002679/ydb/tests/fq/multi_plane/ydb-tests-fq-multi_plane', '--basetemp', '/home/runner/.ya/build/build_root/dyq9/002679/tmp', '--capture', 'no', '-c', 'pkg:library.python.pytest:pytest.yatest.ini', '-p', 'no:factor', '--doctest-modules', '--ya-trace', '/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/ytest.report.trace', '--build-root', '/home/runner/.ya/build/build_root/dyq9/002679', '--source-root', '/home/runner/.ya/build/build_root/dyq9/002679/environment/arcadia', '--output-dir', '/home/runner/.ya/build/build_root/dyq9/002679/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry/testing_out_stuff', '--durations', '0', '--project-path', 'ydb/tests/fq/multi_plane', '--test-tool-bin', '/home/runner/.ya/tools/v4/9985353571/test_tool', '--ya-version', '2', '--collect-cores', '--build-type', 'relwithdebinfo', '--tb', 'short', '--dep-root', 'ydb/tests/fq/multi_plane', '--flags', 'APPLE_SDK_LOCAL=yes', '--flags', 'CFLAGS=-fno-omit-frame-pointer -Wno-unknown-argument', '--flags', 'DEBUGINFO_LINES_ONLY=yes', '--flags', 'DISABLE_FLAKE8_MIGRATIONS=yes', '--flags', 'OPENSOURCE=yes', '--flags', 'TESTS_REQUESTED=yes', '--flags', 'USE_AIO=static', '--flags', 'USE_CLANG_CL=yes', '--flags', 'USE_EAT_MY_DATA=yes', '--flags', 'USE_ICONV=static', '--flags', 'USE_IDN=static', '--flags', 'USE_PREBUILT_TOOLS=no', '--test-file-filter', 'test_retry.py']' stopped by 600 seconds timeout",), {})
============================= test session starts ==============================
platform linux -- Python 3.12.12, pytest-8.0.2, pluggy-1.6.0
rootdir: /home/runner/.ya/build/build_root/dyq9/002676/ydb/tests/fq/multi_plane/test-results/py3test/testing_out_stuff/test_retry_high_rate
configfile: pkg:library.python.pytest:pytest.yatest.ini
plugins: typeguard-2.13.3
collected 1 item

test_retry_high_rate.py .

============================== slowest durations ===============================
218.46s call     test_retry_high_rate.py::TestRetry::test_high_rate[kikimr0]
3.00s teardown test_retry_high_rate.py::TestRetry::test_high_rate[kikimr0]
1.22s setup    test_retry_high_rate.py::TestRetry::test_high_rate[kikimr0]
======================== 1 passed in 223.16s (0:03:43) =========================
