2025-12-04 21:05:32,656 - INFO - ya.test.2675766  - pytest_runtest_setup: ####################################################################################################
2025-12-04 21:05:32,656 - INFO - ya.test.2675766  - pytest_runtest_setup: test_log_uniform
2025-12-04 21:05:32,657 - INFO - ya.test.2675766  - pytest_runtest_setup: ####################################################################################################
2025-12-04 21:05:32,657 - INFO - ya.test.2675766  - pytest_runtest_setup: Test setup
2025-12-04 21:05:32,659 - DEBUG - ya.test.2675766  - _get_command_output_file: Command out will be placed to ydbd.out
2025-12-04 21:05:32,660 - DEBUG - ya.test.2675766  - _get_command_output_file: Command err will be placed to ydbd.err
2025-12-04 21:05:32,660 - DEBUG - ya.test.2675766  - execute: Executing '['/home/runner/.ya/build/build_root/6mdl/004303/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-04 21:05:32,662 - DEBUG - ya.test.2675766  - execute: Command pid: 2678517
2025-12-04 21:05:33,627 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2678517) rc: 0
2025-12-04 21:05:33,627 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2678517) elapsed time (sec): 0.9637508392333984
2025-12-04 21:05:33,628 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2678517) idrss: 0
2025-12-04 21:05:33,628 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2678517) inblock: 0
2025-12-04 21:05:33,628 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2678517) isrss: 0
2025-12-04 21:05:33,628 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2678517) ixrss: 0
2025-12-04 21:05:33,628 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2678517) majflt: 0
2025-12-04 21:05:33,628 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2678517) maxrss: 546880
2025-12-04 21:05:33,629 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2678517) minflt: 16264
2025-12-04 21:05:33,629 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2678517) msgrcv: 0
2025-12-04 21:05:33,629 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2678517) msgsnd: 0
2025-12-04 21:05:33,629 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2678517) nivcsw: 9
2025-12-04 21:05:33,629 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2678517) nsignals: 0
2025-12-04 21:05:33,629 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2678517) nswap: 0
2025-12-04 21:05:33,629 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2678517) nvcsw: 23
2025-12-04 21:05:33,630 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2678517) oublock: 8
2025-12-04 21:05:33,630 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2678517) stime: 0.8146439999999999
2025-12-04 21:05:33,630 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2678517) utime: 0.100843
2025-12-04 21:05:33,630 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2678517) wtime: 0.965
2025-12-04 21:05:33,630 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2678517) output:
Git info:
    Commit: 90dd67a37cfb741f29eee0fef0c766380665ddfd
    Branch: 
    Author: Pavel Velikhov <pavel.velikhov@gmail.com>
    Summary: Merge 0d970fa1db908c828a42e48f6775426d76a77466 into e654da9fb4dc56d3ce85e2435d2c2c6f4757aa6d
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-if77zlumgq    Host information: 
        Linux ghrun-if77zlumgq 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/10302026024/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10302026024/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++

2025-12-04 21:05:33,631 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2678517) errors:

2025-12-04 21:05:33,631 - INFO - __tests__.test_log_scenario.2675766  - _setup_ydb: Git info:
    Commit: 90dd67a37cfb741f29eee0fef0c766380665ddfd
    Branch: 
    Author: Pavel Velikhov <pavel.velikhov@gmail.com>
    Summary: Merge 0d970fa1db908c828a42e48f6775426d76a77466 into e654da9fb4dc56d3ce85e2435d2c2c6f4757aa6d
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-if77zlumgq    Host information: 
        Linux ghrun-if77zlumgq 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/10302026024/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10302026024/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++

2025-12-04 21:05:33,691 - DEBUG - ya.test.2675766  - get_binary: Binary was found by /home/runner/.ya/build/build_root/6mdl/004303/ydb/apps/ydbd/ydbd
2025-12-04 21:05:33,693 - DEBUG - library.python.filelock.2675766  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/23166
2025-12-04 21:05:33,694 - DEBUG - ydb.tests.library.harness.kikimr_runner.2675766  - start: Working directory: /home/runner/.ya/build/build_root/6mdl/004303/r3tmp/kikimr_cluster_8894d6fa
2025-12-04 21:05:33,730 - DEBUG - ya.test.2675766  - get_binary: Binary was found by /home/runner/.ya/build/build_root/6mdl/004303/ydb/apps/ydbd/ydbd
2025-12-04 21:05:33,731 - DEBUG - library.python.filelock.2675766  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/8270
2025-12-04 21:05:33,731 - DEBUG - library.python.filelock.2675766  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/31090
2025-12-04 21:05:33,731 - DEBUG - library.python.filelock.2675766  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/1081
2025-12-04 21:05:33,732 - DEBUG - library.python.filelock.2675766  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/62396
2025-12-04 21:05:33,732 - DEBUG - library.python.filelock.2675766  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/62396
2025-12-04 21:05:33,732 - DEBUG - library.python.filelock.2675766  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/62397
2025-12-04 21:05:33,733 - INFO - ydb.tests.library.harness.kikimr_runner.2675766  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/6mdl/004303/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_log_scenario.py.TestLogScenario.test_log_uniform/cluster/kikimr_configs"
2025-12-04 21:05:33,733 - INFO - ydb.tests.library.harness.kikimr_runner.2675766  - __make_run_command: Final command: /home/runner/.ya/build/build_root/6mdl/004303/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=1 --log-file-name=/home/runner/.ya/build/build_root/6mdl/004303/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_log_scenario.py.TestLogScenario.test_log_uniform/cluster/node_1/logfile_ynkpzlri.log --grpc-port=8270 --mon-port=31090 --ic-port=23166
2025-12-04 21:05:33,733 - DEBUG - ydb.tests.library.harness.kikimr_runner.2675766  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:8270/1, disk_size 68719476736
2025-12-04 21:05:33,734 - INFO - ydb.tests.library.harness.kikimr_runner.2675766  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/6mdl/004303/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_log_scenario.py.TestLogScenario.test_log_uniform/cluster/kikimr_configs"
2025-12-04 21:05:33,734 - INFO - ydb.tests.library.harness.kikimr_runner.2675766  - __make_run_command: Final command: /home/runner/.ya/build/build_root/6mdl/004303/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=1 --log-file-name=/home/runner/.ya/build/build_root/6mdl/004303/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_log_scenario.py.TestLogScenario.test_log_uniform/cluster/node_1/logfile_ynkpzlri.log --grpc-port=8270 --mon-port=31090 --ic-port=23166
2025-12-04 21:05:33,735 - DEBUG - ya.test.2675766  - execute: Executing '('/home/runner/.ya/build/build_root/6mdl/004303/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/6mdl/004303/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_log_scenario.py.TestLogScenario.test_log_uniform/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/6mdl/004303/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_log_scenario.py.TestLogScenario.test_log_uniform/cluster/node_1/logfile_ynkpzlri.log', '--grpc-port=8270', '--mon-port=31090', '--ic-port=23166')' in '/home/runner/.ya/build/build_root/6mdl/004303/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_log_scenario.py.TestLogScenario.test_log_uniform/cluster/node_1' (no wait)
2025-12-04 21:05:33,736 - DEBUG - ya.test.2675766  - execute: Command pid: 2679321
2025-12-04 21:05:33,737 - INFO - ydb.tests.library.harness.kikimr_runner.2675766  - start: Started node localhost:8270/1
2025-12-04 21:05:33,738 - DEBUG - ya.test.2675766  - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-12-04 21:05:33,738 - DEBUG - ya.test.2675766  - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-12-04 21:05:33,739 - DEBUG - ya.test.2675766  - execute: Executing '['/home/runner/.ya/build/build_root/6mdl/004303/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-04 21:05:33,740 - DEBUG - ya.test.2675766  - execute: Command pid: 2679322
2025-12-04 21:05:35,634 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2679322) rc: 0
2025-12-04 21:05:35,635 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2679322) elapsed time (sec): 1.8937828540802002
2025-12-04 21:05:35,635 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2679322) idrss: 0
2025-12-04 21:05:35,635 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2679322) inblock: 0
2025-12-04 21:05:35,635 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2679322) isrss: 0
2025-12-04 21:05:35,635 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2679322) ixrss: 0
2025-12-04 21:05:35,635 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2679322) majflt: 0
2025-12-04 21:05:35,636 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2679322) maxrss: 546944
2025-12-04 21:05:35,636 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2679322) minflt: 16571
2025-12-04 21:05:35,636 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2679322) msgrcv: 0
2025-12-04 21:05:35,636 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2679322) msgsnd: 0
2025-12-04 21:05:35,636 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2679322) nivcsw: 110
2025-12-04 21:05:35,636 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2679322) nsignals: 0
2025-12-04 21:05:35,636 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2679322) nswap: 0
2025-12-04 21:05:35,636 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2679322) nvcsw: 27
2025-12-04 21:05:35,637 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2679322) oublock: 8
2025-12-04 21:05:35,637 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2679322) stime: 1.713541
2025-12-04 21:05:35,637 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2679322) utime: 0.11587
2025-12-04 21:05:35,637 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2679322) wtime: 1.895
2025-12-04 21:05:35,637 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2679322) output:
Git info:
    Commit: 90dd67a37cfb741f29eee0fef0c766380665ddfd
    Branch: 
    Author: Pavel Velikhov <pavel.velikhov@gmail.com>
    Summary: Merge 0d970fa1db908c828a42e48f6775426d76a77466 into e654da9fb4dc56d3ce85e2435d2c2c6f4757aa6d
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-if77zlumgq    Host information: 
        Linux ghrun-if77zlumgq 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/10302026024/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10302026024/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++

2025-12-04 21:05:35,637 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2679322) errors:

2025-12-04 21:05:35,638 - INFO - ydb.tests.library.harness.kikimr_runner.2675766  - start: Node 1 version:
Git info:
    Commit: 90dd67a37cfb741f29eee0fef0c766380665ddfd
    Branch: 
    Author: Pavel Velikhov <pavel.velikhov@gmail.com>
    Summary: Merge 0d970fa1db908c828a42e48f6775426d76a77466 into e654da9fb4dc56d3ce85e2435d2c2c6f4757aa6d
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-if77zlumgq    Host information: 
        Linux ghrun-if77zlumgq 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64
2025-12-04 21:05:38,944 - DEBUG - ya.test.2675766  - get_binary: Binary was found by /home/runner/.ya/build/build_root/6mdl/004303/ydb/apps/ydbd/ydbd
2025-12-04 21:05:38,945 - DEBUG - ydb.tests.library.harness.kikimr_runner.2675766  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/6mdl/004303/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:8270', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineHostConfig {\n    HostConfigId: 1\n    Drive {\n      Path: "SectorMap:1:64"\n    }\n  }\n}\nCommand {\n  DefineBox {\n    BoxId: 1\n    Host {\n      Key {\n        Fqdn: "localhost"\n        IcPort: 23166\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-12-04 21:05:38,946 - DEBUG - ya.test.2675766  - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-12-04 21:05:38,946 - DEBUG - ya.test.2675766  - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-12-04 21:05:38,947 - DEBUG - ya.test.2675766  - execute: Executing '['/home/runner/.ya/build/build_root/6mdl/004303/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:8270', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineHostConfig {\n    HostConfigId: 1\n    Drive {\n      Path: "SectorMap:1:64"\n    }\n  }\n}\nCommand {\n  DefineBox {\n    BoxId: 1\n    Host {\n      Key {\n        Fqdn: "localhost"\n        IcPort: 23166\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-12-04 21:05:38,948 - DEBUG - ya.test.2675766  - execute: Command pid: 2682865
2025-12-04 21:05:39,733 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2682865) rc: 0
2025-12-04 21:05:39,734 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2682865) elapsed time (sec): 0.7849016189575195
2025-12-04 21:05:39,734 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2682865) idrss: 0
2025-12-04 21:05:39,734 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2682865) inblock: 0
2025-12-04 21:05:39,734 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2682865) isrss: 0
2025-12-04 21:05:39,734 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2682865) ixrss: 0
2025-12-04 21:05:39,735 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2682865) majflt: 0
2025-12-04 21:05:39,735 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2682865) maxrss: 555148
2025-12-04 21:05:39,735 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2682865) minflt: 18404
2025-12-04 21:05:39,735 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2682865) msgrcv: 0
2025-12-04 21:05:39,735 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2682865) msgsnd: 0
2025-12-04 21:05:39,735 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2682865) nivcsw: 71
2025-12-04 21:05:39,736 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2682865) nsignals: 0
2025-12-04 21:05:39,736 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2682865) nswap: 0
2025-12-04 21:05:39,736 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2682865) nvcsw: 137
2025-12-04 21:05:39,736 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2682865) oublock: 8
2025-12-04 21:05:39,736 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2682865) stime: 0.605954
2025-12-04 21:05:39,737 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2682865) utime: 0.122904
2025-12-04 21:05:39,737 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2682865) wtime: 0.786
2025-12-04 21:05:39,737 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2682865) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 4

2025-12-04 21:05:39,737 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2682865) errors:

2025-12-04 21:05:39,738 - DEBUG - ya.test.2675766  - get_binary: Binary was found by /home/runner/.ya/build/build_root/6mdl/004303/ydb/apps/ydbd/ydbd
2025-12-04 21:05:39,738 - DEBUG - ydb.tests.library.harness.kikimr_runner.2675766  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/6mdl/004303/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:8270', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']
2025-12-04 21:05:39,739 - DEBUG - ya.test.2675766  - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-12-04 21:05:39,740 - DEBUG - ya.test.2675766  - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-12-04 21:05:39,740 - DEBUG - ya.test.2675766  - execute: Executing '['/home/runner/.ya/build/build_root/6mdl/004303/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:8270', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']' in 'None' (waiting)
2025-12-04 21:05:39,741 - DEBUG - ya.test.2675766  - execute: Command pid: 2683506
2025-12-04 21:05:40,456 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2683506) rc: 0
2025-12-04 21:05:40,461 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2683506) elapsed time (sec): 0.7135913372039795
2025-12-04 21:05:40,461 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2683506) idrss: 0
2025-12-04 21:05:40,461 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2683506) inblock: 0
2025-12-04 21:05:40,461 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2683506) isrss: 0
2025-12-04 21:05:40,462 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2683506) ixrss: 0
2025-12-04 21:05:40,462 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2683506) majflt: 0
2025-12-04 21:05:40,462 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2683506) maxrss: 555148
2025-12-04 21:05:40,462 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2683506) minflt: 18405
2025-12-04 21:05:40,462 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2683506) msgrcv: 0
2025-12-04 21:05:40,463 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2683506) msgsnd: 0
2025-12-04 21:05:40,463 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2683506) nivcsw: 91
2025-12-04 21:05:40,463 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2683506) nsignals: 0
2025-12-04 21:05:40,463 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2683506) nswap: 0
2025-12-04 21:05:40,463 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2683506) nvcsw: 125
2025-12-04 21:05:40,463 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2683506) oublock: 8
2025-12-04 21:05:40,464 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2683506) stime: 0.48522099999999996
2025-12-04 21:05:40,464 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2683506) utime: 0.132108
2025-12-04 21:05:40,464 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2683506) wtime: 0.715
2025-12-04 21:05:40,464 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2683506) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-12-04 21:05:40,465 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2683506) errors:

2025-12-04 21:05:40,467 - INFO - ydb.tests.library.harness.kikimr_runner.2675766  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-12-04 21:05:40,493 - INFO - ydb.tests.library.harness.kikimr_runner.2675766  - __run: Cluster started and initialized
2025-12-04 21:05:40,518 - DEBUG - ydb.connection.2675766  - channel_factory: 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)]
2025-12-04 21:05:40,521 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:05:40,522 - DEBUG - ydb.connection.2675766  - channel_factory: 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)]
2025-12-04 21:05:40,553 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - context_resolve: Resolving endpoints for database /Root
2025-12-04 21:05:40,553 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(ListEndpoints, 62f6007a-a86e-42bb-b0eb-abc51f128ddc, localhost:8270): creating call state
2025-12-04 21:05:40,554 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(ListEndpoints, 62f6007a-a86e-42bb-b0eb-abc51f128ddc, localhost:8270): request = { database: "/Root" }
2025-12-04 21:05:40,558 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(ListEndpoints, 62f6007a-a86e-42bb-b0eb-abc51f128ddc, localhost:8270): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-if77zlumgq.auto.internal" port: 8270 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" } } } }
2025-12-04 21:05:40,559 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-if77zlumgq.auto.internal:8270, location 1, ssl: False>]>
2025-12-04 21:05:40,559 - DEBUG - ydb.connection.2675766  - channel_factory: 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)]
2025-12-04 21:05:40,576 - INFO - ya.test.2675766  - pytest_runtest_call: Test call (class_name: test_log_scenario.py::TestLogScenario, test_name: test_log_uniform)
2025-12-04 21:05:40,577 - DEBUG - ya.test.2675766  - get_binary: Binary was found by /home/runner/.ya/build/build_root/6mdl/004303/ydb/apps/ydb/ydb
2025-12-04 21:05:40,577 - INFO - root.2675766  - _call: YdbWorkloadLog execute /home/runner/.ya/build/build_root/6mdl/004303/ydb/apps/ydb/ydb -e grpc://localhost:8270 -d /Root workload log --path log init --path log --store column --ttl 1000 with wait = True
2025-12-04 21:05:40,579 - DEBUG - ya.test.2675766  - _get_command_output_file: Command out will be placed to ydb.out
2025-12-04 21:05:40,579 - DEBUG - ya.test.2675766  - _get_command_output_file: Command err will be placed to ydb.err
2025-12-04 21:05:40,580 - DEBUG - ya.test.2675766  - execute: Executing '['/home/runner/.ya/build/build_root/6mdl/004303/ydb/apps/ydb/ydb', '-e', 'grpc://localhost:8270', '-d', '/Root', 'workload', 'log', '--path', 'log', 'init', '--path', 'log', '--store', 'column', '--ttl', '1000']' in 'None' (waiting)
2025-12-04 21:05:40,581 - DEBUG - ya.test.2675766  - execute: Command pid: 2684410
2025-12-04 21:05:41,076 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2684410) rc: 0
2025-12-04 21:05:41,076 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2684410) elapsed time (sec): 0.4943270683288574
2025-12-04 21:05:41,077 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2684410) idrss: 0
2025-12-04 21:05:41,077 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2684410) inblock: 0
2025-12-04 21:05:41,077 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2684410) isrss: 0
2025-12-04 21:05:41,077 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2684410) ixrss: 0
2025-12-04 21:05:41,077 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2684410) majflt: 0
2025-12-04 21:05:41,078 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2684410) maxrss: 173420
2025-12-04 21:05:41,078 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2684410) minflt: 3556
2025-12-04 21:05:41,078 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2684410) msgrcv: 0
2025-12-04 21:05:41,078 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2684410) msgsnd: 0
2025-12-04 21:05:41,079 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2684410) nivcsw: 32
2025-12-04 21:05:41,079 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2684410) nsignals: 0
2025-12-04 21:05:41,079 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2684410) nswap: 0
2025-12-04 21:05:41,079 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2684410) nvcsw: 184
2025-12-04 21:05:41,079 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2684410) oublock: 8
2025-12-04 21:05:41,079 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2684410) stime: 0.035716
2025-12-04 21:05:41,080 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2684410) utime: 0.043637999999999996
2025-12-04 21:05:41,080 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2684410) wtime: 0.496
2025-12-04 21:05:41,080 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2684410) output:
Init tables ...
Init tables ...Ok

2025-12-04 21:05:41,080 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2684410) errors:

2025-12-04 21:05:41,081 - INFO - root.2675766  - _insert_rows: YdbWorkloadLog bulk_upsert
2025-12-04 21:05:41,081 - INFO - root.2675766  - _call: YdbWorkloadLog execute /home/runner/.ya/build/build_root/6mdl/004303/ydb/apps/ydb/ydb -e grpc://localhost:8270 -d /Root workload log --path log run bulk_upsert --seconds 30 --threads 10 --rows 1 --date-from 0 --date-to 2678400000 with wait = True
2025-12-04 21:05:41,082 - DEBUG - ya.test.2675766  - _get_command_output_file: Command out will be placed to ydb.out.0
2025-12-04 21:05:41,082 - DEBUG - ya.test.2675766  - _get_command_output_file: Command err will be placed to ydb.err.0
2025-12-04 21:05:41,083 - DEBUG - ya.test.2675766  - execute: Executing '['/home/runner/.ya/build/build_root/6mdl/004303/ydb/apps/ydb/ydb', '-e', 'grpc://localhost:8270', '-d', '/Root', 'workload', 'log', '--path', 'log', 'run', 'bulk_upsert', '--seconds', '30', '--threads', '10', '--rows', '1', '--date-from', '0', '--date-to', '2678400000']' in 'None' (waiting)
2025-12-04 21:05:41,088 - DEBUG - ya.test.2675766  - execute: Command pid: 2684825
2025-12-04 21:06:11,338 - DEBUG - ya.test.2675766  - _wait: Process resource usage is not available as process finished before wait4 was called
2025-12-04 21:06:11,339 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2684825) rc: 0
2025-12-04 21:06:11,339 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2684825) elapsed time (sec): 30.250046968460083
2025-12-04 21:06:11,339 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2684825) wtime: 30.256
2025-12-04 21:06:11,340 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2684825) output:
Window	    Txs	Txs/Sec	Retries	Errors	p50(ms)	p95(ms)	p99(ms)	pMax(ms)
1	    354	354	0	0	23	51	80	85
2	    367	367	0	0	23	60	74	76
3	    347	347	0	0	25	58	63	68
4	    365	365	0	0	23	61	86	94
5	    352	352	0	0	23	69	99	104
6	    374	374	0	0	22	44	104	115
7	    387	387	0	0	23	41	51	55
8	    362	362	0	0	25	46	54	57
9	    434	434	0	0	21	32	38	40
10	    471	471	0	0	20	26	42	47
11	    470	470	0	0	20	26	29	31
12	    442	442	0	0	21	32	44	49
13	    409	409	0	0	23	34	39	44
14	    437	437	0	0	21	34	42	46
15	    403	403	0	0	22	42	49	55
16	    427	427	0	0	21	35	59	71
17	    462	462	0	0	21	28	30	33
18	    447	447	0	0	21	28	31	34
19	    430	430	0	0	22	36	44	49
20	    463	463	0	0	20	29	33	36
21	    459	459	0	0	21	27	31	35
22	    440	440	0	0	21	30	33	36
23	    473	473	0	0	20	25	28	30
24	    425	425	0	0	22	33	40	43
25	    412	412	0	0	22	35	41	46
26	    445	445	0	0	21	30	35	37
27	    450	450	0	0	21	31	35	37
28	    407	407	0	0	23	35	39	42
29	    133	133	0	0	26	345	433	439
30	    406	406	0	0	24	40	117	122

Total	    Txs	Txs/Sec	Retries	Errors	p50(ms)	p95(ms)	p99(ms)	pMax(ms)
30	  12253	408.433	0	0	21	37	63	439

2025-12-04 21:06:11,340 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2684825) errors:

2025-12-04 21:06:11,340 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:11,341 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(CreateSession, e7ba0b6f-2682-4e47-b6d2-012a1f983d49, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:11,342 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(CreateSession, e7ba0b6f-2682-4e47-b6d2-012a1f983d49, ghrun-if77zlumgq.auto.internal:8270): request = {  }
2025-12-04 21:06:11,344 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(CreateSession, e7ba0b6f-2682-4e47-b6d2-012a1f983d49, ghrun-if77zlumgq.auto.internal:8270): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=NzgzZTMyOGQtMmYxN2E4MWYtZjI2YjE1NjEtYzY3MGYyMGE=" node_id: 1 }
2025-12-04 21:06:11,345 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(AttachSession, 0e4dc27b-225f-401a-bfde-959079933259, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:11,345 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(AttachSession, 0e4dc27b-225f-401a-bfde-959079933259, ghrun-if77zlumgq.auto.internal:8270): request = { session_id: "ydb://session/3?node_id=1&id=NzgzZTMyOGQtMmYxN2E4MWYtZjI2YjE1NjEtYzY3MGYyMGE=" }
2025-12-04 21:06:11,347 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(AttachSession, 0e4dc27b-225f-401a-bfde-959079933259, ghrun-if77zlumgq.auto.internal:8270): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:06:11,350 - DEBUG - ydb.query.pool.2675766  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=NzgzZTMyOGQtMmYxN2E4MWYtZjI2YjE1NjEtYzY3MGYyMGE=
2025-12-04 21:06:11,351 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(ExecuteQuery, 8bbbf091-aeb4-40ce-84f4-6a783c88fadf, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:11,351 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(ExecuteQuery, 8bbbf091-aeb4-40ce-84f4-6a783c88fadf, ghrun-if77zlumgq.auto.internal:8270): request = { session_id: "ydb://session/3?node_id=1&id=NzgzZTMyOGQtMmYxN2E4MWYtZjI2YjE1NjEtYzY3MGYyMGE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select count(*) as Rows from `log`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:06:11,352 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(ExecuteQuery, 8bbbf091-aeb4-40ce-84f4-6a783c88fadf, ghrun-if77zlumgq.auto.internal:8270): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:06:11,816 - DEBUG - ydb.query.pool.2675766  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgzZTMyOGQtMmYxN2E4MWYtZjI2YjE1NjEtYzY3MGYyMGE=
2025-12-04 21:06:11,816 - INFO - root.2675766  - test_log_uniform: Count rows after insert 11966 before wait
2025-12-04 21:06:11,816 - DEBUG - ydb.query.pool.2675766  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgzZTMyOGQtMmYxN2E4MWYtZjI2YjE1NjEtYzY3MGYyMGE=
2025-12-04 21:06:11,817 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(ExecuteQuery, 843e1c99-98d7-4dc9-96eb-2855293f95fe, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:11,817 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(ExecuteQuery, 843e1c99-98d7-4dc9-96eb-2855293f95fe, ghrun-if77zlumgq.auto.internal:8270): request = { session_id: "ydb://session/3?node_id=1&id=NzgzZTMyOGQtMmYxN2E4MWYtZjI2YjE1NjEtYzY3MGYyMGE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select count(*) as Rows from `log`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:06:11,818 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(ExecuteQuery, 843e1c99-98d7-4dc9-96eb-2855293f95fe, ghrun-if77zlumgq.auto.internal:8270): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:06:12,065 - DEBUG - ydb.query.pool.2675766  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgzZTMyOGQtMmYxN2E4MWYtZjI2YjE1NjEtYzY3MGYyMGE=
2025-12-04 21:06:12,066 - DEBUG - ydb.query.pool.2675766  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgzZTMyOGQtMmYxN2E4MWYtZjI2YjE1NjEtYzY3MGYyMGE=
2025-12-04 21:06:12,066 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(ExecuteQuery, c55b13d7-a937-4fbc-9368-95c23094dcd8, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:12,067 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(ExecuteQuery, c55b13d7-a937-4fbc-9368-95c23094dcd8, ghrun-if77zlumgq.auto.internal:8270): request = { session_id: "ydb://session/3?node_id=1&id=NzgzZTMyOGQtMmYxN2E4MWYtZjI2YjE1NjEtYzY3MGYyMGE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select count(*) as Rows from `log`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:06:12,068 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(ExecuteQuery, c55b13d7-a937-4fbc-9368-95c23094dcd8, ghrun-if77zlumgq.auto.internal:8270): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:06:12,278 - DEBUG - ydb.query.pool.2675766  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzgzZTMyOGQtMmYxN2E4MWYtZjI2YjE1NjEtYzY3MGYyMGE=
2025-12-04 21:06:12,279 - INFO - root.2675766  - _insert_rows: YdbWorkloadLog bulk_upsert
2025-12-04 21:06:12,280 - INFO - root.2675766  - _insert_rows: YdbWorkloadLog insert
2025-12-04 21:06:12,280 - INFO - root.2675766  - _call: YdbWorkloadLog execute /home/runner/.ya/build/build_root/6mdl/004303/ydb/apps/ydb/ydb -e grpc://localhost:8270 -d /Root workload log --path log run bulk_upsert --seconds 30 --threads 10 --rows 1 --date-from 0 --date-to 2678400000 with wait = True
2025-12-04 21:06:12,281 - INFO - root.2675766  - _call: YdbWorkloadLog execute /home/runner/.ya/build/build_root/6mdl/004303/ydb/apps/ydb/ydb -e grpc://localhost:8270 -d /Root workload log --path log run insert --seconds 30 --threads 10 --rows 1 --date-from 0 --date-to 2678400000 with wait = True
2025-12-04 21:06:12,283 - INFO - root.2675766  - _insert_rows: YdbWorkloadLog upsert
2025-12-04 21:06:12,283 - INFO - root.2675766  - _call: YdbWorkloadLog execute /home/runner/.ya/build/build_root/6mdl/004303/ydb/apps/ydb/ydb -e grpc://localhost:8270 -d /Root workload log --path log run upsert --seconds 30 --threads 10 --rows 1 --date-from 0 --date-to 2678400000 with wait = True
2025-12-04 21:06:12,285 - DEBUG - ydb.query.pool.2675766  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzgzZTMyOGQtMmYxN2E4MWYtZjI2YjE1NjEtYzY3MGYyMGE=
2025-12-04 21:06:12,286 - DEBUG - ya.test.2675766  - _get_command_output_file: Command out will be placed to ydb.out.2
2025-12-04 21:06:12,286 - DEBUG - ya.test.2675766  - _get_command_output_file: Command out will be placed to ydb.out.3
2025-12-04 21:06:12,286 - DEBUG - ya.test.2675766  - _get_command_output_file: Command out will be placed to ydb.out.1
2025-12-04 21:06:12,287 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(ExecuteQuery, 341c93ac-0eb8-466e-a1d6-866dc5ce4cee, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:12,288 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 1 < 100, will create new one.
2025-12-04 21:06:12,292 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(ExecuteQuery, 341c93ac-0eb8-466e-a1d6-866dc5ce4cee, ghrun-if77zlumgq.auto.internal:8270): request = { session_id: "ydb://session/3?node_id=1&id=NzgzZTMyOGQtMmYxN2E4MWYtZjI2YjE1NjEtYzY3MGYyMGE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:06:12,292 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(CreateSession, 7a7e9922-5afb-442a-b000-adccfa154fd0, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:12,296 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(CreateSession, 7a7e9922-5afb-442a-b000-adccfa154fd0, ghrun-if77zlumgq.auto.internal:8270): request = {  }
2025-12-04 21:06:12,295 - DEBUG - ya.test.2675766  - _get_command_output_file: Command err will be placed to ydb.err.2
2025-12-04 21:06:12,295 - DEBUG - ya.test.2675766  - _get_command_output_file: Command err will be placed to ydb.err.1
2025-12-04 21:06:12,296 - DEBUG - ya.test.2675766  - _get_command_output_file: Command err will be placed to ydb.err.3
2025-12-04 21:06:12,294 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(ExecuteQuery, 341c93ac-0eb8-466e-a1d6-866dc5ce4cee, ghrun-if77zlumgq.auto.internal:8270): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:06:12,297 - DEBUG - ya.test.2675766  - execute: Executing '['/home/runner/.ya/build/build_root/6mdl/004303/ydb/apps/ydb/ydb', '-e', 'grpc://localhost:8270', '-d', '/Root', 'workload', 'log', '--path', 'log', 'run', 'upsert', '--seconds', '30', '--threads', '10', '--rows', '1', '--date-from', '0', '--date-to', '2678400000']' in 'None' (waiting)
2025-12-04 21:06:12,298 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(CreateSession, 7a7e9922-5afb-442a-b000-adccfa154fd0, ghrun-if77zlumgq.auto.internal:8270): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=Mjc1MWVkNjItOTc4MDM0NmUtOTgzMTE1YTgtMThlMjRlN2Y=" node_id: 1 }
2025-12-04 21:06:12,299 - DEBUG - ya.test.2675766  - execute: Executing '['/home/runner/.ya/build/build_root/6mdl/004303/ydb/apps/ydb/ydb', '-e', 'grpc://localhost:8270', '-d', '/Root', 'workload', 'log', '--path', 'log', 'run', 'insert', '--seconds', '30', '--threads', '10', '--rows', '1', '--date-from', '0', '--date-to', '2678400000']' in 'None' (waiting)
2025-12-04 21:06:12,299 - DEBUG - ya.test.2675766  - execute: Executing '['/home/runner/.ya/build/build_root/6mdl/004303/ydb/apps/ydb/ydb', '-e', 'grpc://localhost:8270', '-d', '/Root', 'workload', 'log', '--path', 'log', 'run', 'bulk_upsert', '--seconds', '30', '--threads', '10', '--rows', '1', '--date-from', '0', '--date-to', '2678400000']' in 'None' (waiting)
2025-12-04 21:06:12,301 - DEBUG - ya.test.2675766  - execute: Command pid: 2708795
2025-12-04 21:06:12,301 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(AttachSession, 4091ad79-c945-4449-9d81-94b70ad19f3a, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:12,303 - DEBUG - ya.test.2675766  - execute: Command pid: 2708799
2025-12-04 21:06:12,304 - DEBUG - ya.test.2675766  - execute: Command pid: 2708801
2025-12-04 21:06:12,305 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(AttachSession, 4091ad79-c945-4449-9d81-94b70ad19f3a, ghrun-if77zlumgq.auto.internal:8270): request = { session_id: "ydb://session/3?node_id=1&id=Mjc1MWVkNjItOTc4MDM0NmUtOTgzMTE1YTgtMThlMjRlN2Y=" }
2025-12-04 21:06:12,307 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(AttachSession, 4091ad79-c945-4449-9d81-94b70ad19f3a, ghrun-if77zlumgq.auto.internal:8270): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:06:12,313 - DEBUG - ydb.query.pool.2675766  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=Mjc1MWVkNjItOTc4MDM0NmUtOTgzMTE1YTgtMThlMjRlN2Y=
2025-12-04 21:06:12,313 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(ExecuteQuery, 7b9e5633-985b-4be3-b8a6-24f594a7f7e8, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:12,314 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(ExecuteQuery, 7b9e5633-985b-4be3-b8a6-24f594a7f7e8, ghrun-if77zlumgq.auto.internal:8270): request = { session_id: "ydb://session/3?node_id=1&id=Mjc1MWVkNjItOTc4MDM0NmUtOTgzMTE1YTgtMThlMjRlN2Y=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:06:12,314 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(ExecuteQuery, 7b9e5633-985b-4be3-b8a6-24f594a7f7e8, ghrun-if77zlumgq.auto.internal:8270): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:06:12,315 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 2 < 100, will create new one.
2025-12-04 21:06:12,315 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(CreateSession, 31a08c24-9c36-4f6e-b5a4-e594c4d60af9, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:12,315 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(CreateSession, 31a08c24-9c36-4f6e-b5a4-e594c4d60af9, ghrun-if77zlumgq.auto.internal:8270): request = {  }
2025-12-04 21:06:12,318 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(CreateSession, 31a08c24-9c36-4f6e-b5a4-e594c4d60af9, ghrun-if77zlumgq.auto.internal:8270): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=ZWRjNDRmYjUtYmZmMDFlZDYtOGYwYjgzZTItOGY1Yzk=" node_id: 1 }
2025-12-04 21:06:12,319 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(AttachSession, c6832497-dfd0-4be2-81b6-7558cca7c0c4, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:12,319 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(AttachSession, c6832497-dfd0-4be2-81b6-7558cca7c0c4, ghrun-if77zlumgq.auto.internal:8270): request = { session_id: "ydb://session/3?node_id=1&id=ZWRjNDRmYjUtYmZmMDFlZDYtOGYwYjgzZTItOGY1Yzk=" }
2025-12-04 21:06:12,319 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(AttachSession, c6832497-dfd0-4be2-81b6-7558cca7c0c4, ghrun-if77zlumgq.auto.internal:8270): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:06:12,321 - DEBUG - ydb.query.pool.2675766  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=ZWRjNDRmYjUtYmZmMDFlZDYtOGYwYjgzZTItOGY1Yzk=
2025-12-04 21:06:12,322 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(ExecuteQuery, 35c0b812-f82d-46b5-9217-4c56e494f05c, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:12,322 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(ExecuteQuery, 35c0b812-f82d-46b5-9217-4c56e494f05c, ghrun-if77zlumgq.auto.internal:8270): request = { session_id: "ydb://session/3?node_id=1&id=ZWRjNDRmYjUtYmZmMDFlZDYtOGYwYjgzZTItOGY1Yzk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:06:12,323 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(ExecuteQuery, 35c0b812-f82d-46b5-9217-4c56e494f05c, ghrun-if77zlumgq.auto.internal:8270): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:06:12,322 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 3 < 100, will create new one.
2025-12-04 21:06:12,324 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(CreateSession, 551f99b3-d57d-4803-87ca-653a9aa6e63c, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:12,324 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(CreateSession, 551f99b3-d57d-4803-87ca-653a9aa6e63c, ghrun-if77zlumgq.auto.internal:8270): request = {  }
2025-12-04 21:06:12,326 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(CreateSession, 551f99b3-d57d-4803-87ca-653a9aa6e63c, ghrun-if77zlumgq.auto.internal:8270): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=M2JjNWViMGEtNDgyZGUyYjUtMmRiZDdmOTctMTZhOWJhZjg=" node_id: 1 }
2025-12-04 21:06:12,327 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(AttachSession, b5b562cd-e7de-4388-b016-7087e9ab7c03, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:12,327 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(AttachSession, b5b562cd-e7de-4388-b016-7087e9ab7c03, ghrun-if77zlumgq.auto.internal:8270): request = { session_id: "ydb://session/3?node_id=1&id=M2JjNWViMGEtNDgyZGUyYjUtMmRiZDdmOTctMTZhOWJhZjg=" }
2025-12-04 21:06:12,328 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(AttachSession, b5b562cd-e7de-4388-b016-7087e9ab7c03, ghrun-if77zlumgq.auto.internal:8270): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:06:12,329 - DEBUG - ydb.query.pool.2675766  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=M2JjNWViMGEtNDgyZGUyYjUtMmRiZDdmOTctMTZhOWJhZjg=
2025-12-04 21:06:12,329 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 4 < 100, will create new one.
2025-12-04 21:06:12,330 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(ExecuteQuery, 634175a4-c8e0-4f6b-8cc4-05dcca2d4b7b, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:12,330 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(CreateSession, 90e12ffa-3a9c-4d4e-ac36-36c42daa82f0, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:12,331 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(ExecuteQuery, 634175a4-c8e0-4f6b-8cc4-05dcca2d4b7b, ghrun-if77zlumgq.auto.internal:8270): request = { session_id: "ydb://session/3?node_id=1&id=M2JjNWViMGEtNDgyZGUyYjUtMmRiZDdmOTctMTZhOWJhZjg=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:06:12,332 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(ExecuteQuery, 634175a4-c8e0-4f6b-8cc4-05dcca2d4b7b, ghrun-if77zlumgq.auto.internal:8270): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:06:12,331 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(CreateSession, 90e12ffa-3a9c-4d4e-ac36-36c42daa82f0, ghrun-if77zlumgq.auto.internal:8270): request = {  }
2025-12-04 21:06:12,334 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(CreateSession, 90e12ffa-3a9c-4d4e-ac36-36c42daa82f0, ghrun-if77zlumgq.auto.internal:8270): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=MjFiMTE1ZjEtZmU2NTIzM2YtZmVlYmNmYWMtMWFiNjE4NDY=" node_id: 1 }
2025-12-04 21:06:12,335 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(AttachSession, 8b1a5f94-01b0-496d-ae95-aad8b4fd0b49, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:12,335 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(AttachSession, 8b1a5f94-01b0-496d-ae95-aad8b4fd0b49, ghrun-if77zlumgq.auto.internal:8270): request = { session_id: "ydb://session/3?node_id=1&id=MjFiMTE1ZjEtZmU2NTIzM2YtZmVlYmNmYWMtMWFiNjE4NDY=" }
2025-12-04 21:06:12,336 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(AttachSession, 8b1a5f94-01b0-496d-ae95-aad8b4fd0b49, ghrun-if77zlumgq.auto.internal:8270): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:06:12,338 - DEBUG - ydb.query.pool.2675766  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=MjFiMTE1ZjEtZmU2NTIzM2YtZmVlYmNmYWMtMWFiNjE4NDY=
2025-12-04 21:06:12,338 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(ExecuteQuery, ebb43b01-91fd-413a-a091-d3c712c43a7c, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:12,339 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(ExecuteQuery, ebb43b01-91fd-413a-a091-d3c712c43a7c, ghrun-if77zlumgq.auto.internal:8270): request = { session_id: "ydb://session/3?node_id=1&id=MjFiMTE1ZjEtZmU2NTIzM2YtZmVlYmNmYWMtMWFiNjE4NDY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:06:12,339 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(ExecuteQuery, ebb43b01-91fd-413a-a091-d3c712c43a7c, ghrun-if77zlumgq.auto.internal:8270): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:06:12,340 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 5 < 100, will create new one.
2025-12-04 21:06:12,340 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(CreateSession, 31031cf8-eaf5-4823-9394-9a89784c61f1, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:12,341 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(CreateSession, 31031cf8-eaf5-4823-9394-9a89784c61f1, ghrun-if77zlumgq.auto.internal:8270): request = {  }
2025-12-04 21:06:12,343 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(CreateSession, 31031cf8-eaf5-4823-9394-9a89784c61f1, ghrun-if77zlumgq.auto.internal:8270): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=MWUyM2JiY2YtNDZlMWRhMi0yNWUzZDNmNi1hMzFlY2ZkYg==" node_id: 1 }
2025-12-04 21:06:12,343 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(AttachSession, a4e97bd2-1f99-4d0d-b5fa-47620bafa52f, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:12,343 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(AttachSession, a4e97bd2-1f99-4d0d-b5fa-47620bafa52f, ghrun-if77zlumgq.auto.internal:8270): request = { session_id: "ydb://session/3?node_id=1&id=MWUyM2JiY2YtNDZlMWRhMi0yNWUzZDNmNi1hMzFlY2ZkYg==" }
2025-12-04 21:06:12,344 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(AttachSession, a4e97bd2-1f99-4d0d-b5fa-47620bafa52f, ghrun-if77zlumgq.auto.internal:8270): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:06:12,361 - DEBUG - ydb.query.pool.2675766  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=MWUyM2JiY2YtNDZlMWRhMi0yNWUzZDNmNi1hMzFlY2ZkYg==
2025-12-04 21:06:12,362 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(ExecuteQuery, 6ead9e87-a51d-4084-9019-10500ee89ac9, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:12,362 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(ExecuteQuery, 6ead9e87-a51d-4084-9019-10500ee89ac9, ghrun-if77zlumgq.auto.internal:8270): request = { session_id: "ydb://session/3?node_id=1&id=MWUyM2JiY2YtNDZlMWRhMi0yNWUzZDNmNi1hMzFlY2ZkYg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:06:12,363 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(ExecuteQuery, 6ead9e87-a51d-4084-9019-10500ee89ac9, ghrun-if77zlumgq.auto.internal:8270): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:06:12,364 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 6 < 100, will create new one.
2025-12-04 21:06:12,364 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(CreateSession, afe80729-330a-4bbf-89c7-7c4da5e42b05, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:12,364 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(CreateSession, afe80729-330a-4bbf-89c7-7c4da5e42b05, ghrun-if77zlumgq.auto.internal:8270): request = {  }
2025-12-04 21:06:12,409 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(CreateSession, afe80729-330a-4bbf-89c7-7c4da5e42b05, ghrun-if77zlumgq.auto.internal:8270): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=YTNmZGZlZDUtMTE1ZTZkY2EtNWRhNTNmNC02NWZjYjQwOA==" node_id: 1 }
2025-12-04 21:06:12,410 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(AttachSession, 72d2c9f0-afab-4b23-968f-71bb1539ba66, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:12,410 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(AttachSession, 72d2c9f0-afab-4b23-968f-71bb1539ba66, ghrun-if77zlumgq.auto.internal:8270): request = { session_id: "ydb://session/3?node_id=1&id=YTNmZGZlZDUtMTE1ZTZkY2EtNWRhNTNmNC02NWZjYjQwOA==" }
2025-12-04 21:06:12,410 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(AttachSession, 72d2c9f0-afab-4b23-968f-71bb1539ba66, ghrun-if77zlumgq.auto.internal:8270): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:06:12,432 - DEBUG - ydb.query.pool.2675766  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=YTNmZGZlZDUtMTE1ZTZkY2EtNWRhNTNmNC02NWZjYjQwOA==
2025-12-04 21:06:12,433 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(ExecuteQuery, e8310068-54f0-4f38-b574-48186f41ba6f, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:12,434 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(ExecuteQuery, e8310068-54f0-4f38-b574-48186f41ba6f, ghrun-if77zlumgq.auto.internal:8270): request = { session_id: "ydb://session/3?node_id=1&id=YTNmZGZlZDUtMTE1ZTZkY2EtNWRhNTNmNC02NWZjYjQwOA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:06:12,435 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(ExecuteQuery, e8310068-54f0-4f38-b574-48186f41ba6f, ghrun-if77zlumgq.auto.internal:8270): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:06:12,436 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 7 < 100, will create new one.
2025-12-04 21:06:12,437 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(CreateSession, 63fc3927-b6fb-40e9-b244-d767cd1b92f1, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:12,437 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(CreateSession, 63fc3927-b6fb-40e9-b244-d767cd1b92f1, ghrun-if77zlumgq.auto.internal:8270): request = {  }
2025-12-04 21:06:12,453 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(CreateSession, 63fc3927-b6fb-40e9-b244-d767cd1b92f1, ghrun-if77zlumgq.auto.internal:8270): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=MmM2ODg2OWItODJlNjBlYzUtMzY5MmIwZTQtNjkwZTM0NjE=" node_id: 1 }
2025-12-04 21:06:12,454 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(AttachSession, 8c65ce1e-ce30-4b2e-bb8a-88ec24617898, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:12,454 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(AttachSession, 8c65ce1e-ce30-4b2e-bb8a-88ec24617898, ghrun-if77zlumgq.auto.internal:8270): request = { session_id: "ydb://session/3?node_id=1&id=MmM2ODg2OWItODJlNjBlYzUtMzY5MmIwZTQtNjkwZTM0NjE=" }
2025-12-04 21:06:12,455 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(AttachSession, 8c65ce1e-ce30-4b2e-bb8a-88ec24617898, ghrun-if77zlumgq.auto.internal:8270): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:06:12,482 - DEBUG - ydb.query.pool.2675766  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=MmM2ODg2OWItODJlNjBlYzUtMzY5MmIwZTQtNjkwZTM0NjE=
2025-12-04 21:06:12,483 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(ExecuteQuery, 3b2b0334-e96a-40fb-bbb6-977019434984, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:12,483 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 8 < 100, will create new one.
2025-12-04 21:06:12,484 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(ExecuteQuery, 3b2b0334-e96a-40fb-bbb6-977019434984, ghrun-if77zlumgq.auto.internal:8270): request = { session_id: "ydb://session/3?node_id=1&id=MmM2ODg2OWItODJlNjBlYzUtMzY5MmIwZTQtNjkwZTM0NjE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:06:12,485 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(CreateSession, 085e746d-7b65-4323-a9ec-1abfcf3baf36, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:12,486 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(ExecuteQuery, 3b2b0334-e96a-40fb-bbb6-977019434984, ghrun-if77zlumgq.auto.internal:8270): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:06:12,486 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(CreateSession, 085e746d-7b65-4323-a9ec-1abfcf3baf36, ghrun-if77zlumgq.auto.internal:8270): request = {  }
2025-12-04 21:06:12,501 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(CreateSession, 085e746d-7b65-4323-a9ec-1abfcf3baf36, ghrun-if77zlumgq.auto.internal:8270): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=ZDNhOGFjOWMtM2QwMDcxOTgtZDJkOTcyNzktNmIyOWVkNDc=" node_id: 1 }
2025-12-04 21:06:12,501 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(AttachSession, 7aae031e-8ac9-41f9-a93f-52617e54f063, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:12,502 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(AttachSession, 7aae031e-8ac9-41f9-a93f-52617e54f063, ghrun-if77zlumgq.auto.internal:8270): request = { session_id: "ydb://session/3?node_id=1&id=ZDNhOGFjOWMtM2QwMDcxOTgtZDJkOTcyNzktNmIyOWVkNDc=" }
2025-12-04 21:06:12,502 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(AttachSession, 7aae031e-8ac9-41f9-a93f-52617e54f063, ghrun-if77zlumgq.auto.internal:8270): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:06:12,537 - DEBUG - ydb.query.pool.2675766  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=ZDNhOGFjOWMtM2QwMDcxOTgtZDJkOTcyNzktNmIyOWVkNDc=
2025-12-04 21:06:12,537 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(ExecuteQuery, 0cd16d32-45cd-4789-9488-335c5268342d, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:12,538 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(ExecuteQuery, 0cd16d32-45cd-4789-9488-335c5268342d, ghrun-if77zlumgq.auto.internal:8270): request = { session_id: "ydb://session/3?node_id=1&id=ZDNhOGFjOWMtM2QwMDcxOTgtZDJkOTcyNzktNmIyOWVkNDc=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:06:12,539 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(ExecuteQuery, 0cd16d32-45cd-4789-9488-335c5268342d, ghrun-if77zlumgq.auto.internal:8270): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:06:12,539 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 9 < 100, will create new one.
2025-12-04 21:06:12,540 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(CreateSession, 3d6416ae-34e8-489b-a5a0-80251c7a25ed, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:12,541 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(CreateSession, 3d6416ae-34e8-489b-a5a0-80251c7a25ed, ghrun-if77zlumgq.auto.internal:8270): request = {  }
2025-12-04 21:06:12,557 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(CreateSession, 3d6416ae-34e8-489b-a5a0-80251c7a25ed, ghrun-if77zlumgq.auto.internal:8270): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=YTU2ZGY3NWQtMzY4YzE1MWUtOTdmZDFhY2YtZDk3ODZlZGM=" node_id: 1 }
2025-12-04 21:06:12,558 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(AttachSession, 9ecf1589-8564-462e-8b78-8788450531ad, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:12,558 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(AttachSession, 9ecf1589-8564-462e-8b78-8788450531ad, ghrun-if77zlumgq.auto.internal:8270): request = { session_id: "ydb://session/3?node_id=1&id=YTU2ZGY3NWQtMzY4YzE1MWUtOTdmZDFhY2YtZDk3ODZlZGM=" }
2025-12-04 21:06:12,559 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(AttachSession, 9ecf1589-8564-462e-8b78-8788450531ad, ghrun-if77zlumgq.auto.internal:8270): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:06:12,568 - DEBUG - ydb.query.pool.2675766  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=YTU2ZGY3NWQtMzY4YzE1MWUtOTdmZDFhY2YtZDk3ODZlZGM=
2025-12-04 21:06:12,569 - DEBUG - ydb.connection.2675766  - _prepare_call: RpcState(ExecuteQuery, e63ccf9d-b6f4-48a0-8da1-3f2d7df02e24, ghrun-if77zlumgq.auto.internal:8270): creating call state
2025-12-04 21:06:12,570 - DEBUG - ydb.connection.2675766  - _log_request: RpcState(ExecuteQuery, e63ccf9d-b6f4-48a0-8da1-3f2d7df02e24, ghrun-if77zlumgq.auto.internal:8270): request = { session_id: "ydb://session/3?node_id=1&id=YTU2ZGY3NWQtMzY4YzE1MWUtOTdmZDFhY2YtZDk3ODZlZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:06:12,570 - DEBUG - ydb.connection.2675766  - _log_response: RpcState(ExecuteQuery, e63ccf9d-b6f4-48a0-8da1-3f2d7df02e24, ghrun-if77zlumgq.auto.internal:8270): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:06:18,885 - DEBUG - ydb.connection.2675766  - _rpc_error_handler: RpcState(AttachSession, 4091ad79-c945-4449-9d81-94b70ad19f3a, ghrun-if77zlumgq.auto.internal:8270): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer ipv4:127.0.1.1:8270 {file:"contrib/libs/grpc/src/core/lib/surface/call.cc", file_line:1211, created_time:"2025-12-04T21:06:18.878080594+00:00", grpc_status:14, grpc_message:"recvmsg:Connection reset by peer"}"
>
2025-12-04 21:06:18,888 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint ghrun-if77zlumgq.auto.internal:8270
2025-12-04 21:06:18,886 - DEBUG - ydb.connection.2675766  - _rpc_error_handler: RpcState(AttachSession, 0e4dc27b-225f-401a-bfde-959079933259, ghrun-if77zlumgq.auto.internal:8270): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer ipv4:127.0.1.1:8270 {file:"contrib/libs/grpc/src/core/lib/surface/call.cc", file_line:1211, created_time:"2025-12-04T21:06:18.877892137+00:00", grpc_status:14, grpc_message:"recvmsg:Connection reset by peer"}"
>
2025-12-04 21:06:18,886 - DEBUG - ydb.connection.2675766  - _rpc_error_handler: RpcState(AttachSession, c6832497-dfd0-4be2-81b6-7558cca7c0c4, ghrun-if77zlumgq.auto.internal:8270): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer ipv4:127.0.1.1:8270 {file:"contrib/libs/grpc/src/core/lib/surface/call.cc", file_line:1211, created_time:"2025-12-04T21:06:18.878125941+00:00", grpc_status:14, grpc_message:"recvmsg:Connection reset by peer"}"
>
2025-12-04 21:06:18,890 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint ghrun-if77zlumgq.auto.internal:8270
2025-12-04 21:06:18,889 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint ghrun-if77zlumgq.auto.internal:8270
2025-12-04 21:06:18,893 - DEBUG - ydb.connection.2675766  - _rpc_error_handler: RpcState(AttachSession, 8b1a5f94-01b0-496d-ae95-aad8b4fd0b49, ghrun-if77zlumgq.auto.internal:8270): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer ipv4:127.0.1.1:8270 {file:"contrib/libs/grpc/src/core/lib/surface/call.cc", file_line:1211, created_time:"2025-12-04T21:06:18.878196045+00:00", grpc_status:14, grpc_message:"recvmsg:Connection reset by peer"}"
>
2025-12-04 21:06:18,896 - DEBUG - ydb.connection.2675766  - _rpc_error_handler: RpcState(ExecuteQuery, e63ccf9d-b6f4-48a0-8da1-3f2d7df02e24, ghrun-if77zlumgq.auto.internal:8270): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer  {file:"contrib/libs/grpc/src/core/lib/surface/call.cc", file_line:1211, created_time:"2025-12-04T21:06:18.878384001+00:00", grpc_status:14, grpc_message:"recvmsg:Connection reset by peer"}"
>
2025-12-04 21:06:18,901 - DEBUG - ydb.connection.2675766  - _rpc_error_handler: RpcState(AttachSession, 72d2c9f0-afab-4b23-968f-71bb1539ba66, ghrun-if77zlumgq.auto.internal:8270): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer ipv4:127.0.1.1:8270 {grpc_message:"recvmsg:Connection reset by peer", grpc_status:14, created_time:"2025-12-04T21:06:18.878269794+00:00", file_line:1211, file:"contrib/libs/grpc/src/core/lib/surface/call.cc"}"
>
2025-12-04 21:06:18,901 - DEBUG - ydb.connection.2675766  - _rpc_error_handler: RpcState(ExecuteQuery, 3b2b0334-e96a-40fb-bbb6-977019434984, ghrun-if77zlumgq.auto.internal:8270): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer  {grpc_message:"recvmsg:Connection reset by peer", grpc_status:14, created_time:"2025-12-04T21:06:18.878325148+00:00", file_line:1211, file:"contrib/libs/grpc/src/core/lib/surface/call.cc"}"
>
2025-12-04 21:06:18,902 - DEBUG - ydb.connection.2675766  - _rpc_error_handler: RpcState(ExecuteQuery, 35c0b812-f82d-46b5-9217-4c56e494f05c, ghrun-if77zlumgq.auto.internal:8270): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer  {file:"contrib/libs/grpc/src/core/lib/surface/call.cc", file_line:1211, created_time:"2025-12-04T21:06:18.878142081+00:00", grpc_status:14, grpc_message:"recvmsg:Connection reset by peer"}"
>
2025-12-04 21:06:18,902 - DEBUG - ydb.connection.2675766  - _rpc_error_handler: RpcState(ExecuteQuery, e8310068-54f0-4f38-b574-48186f41ba6f, ghrun-if77zlumgq.auto.internal:8270): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer  {file:"contrib/libs/grpc/src/core/lib/surface/call.cc", file_line:1211, created_time:"2025-12-04T21:06:18.878284998+00:00", grpc_status:14, grpc_message:"recvmsg:Connection reset by peer"}"
>
2025-12-04 21:06:18,915 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint ghrun-if77zlumgq.auto.internal:8270
2025-12-04 21:06:18,902 - DEBUG - ydb.connection.2675766  - _rpc_error_handler: RpcState(ExecuteQuery, 0cd16d32-45cd-4789-9488-335c5268342d, ghrun-if77zlumgq.auto.internal:8270): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer  {file:"contrib/libs/grpc/src/core/lib/surface/call.cc", file_line:1211, created_time:"2025-12-04T21:06:18.878359087+00:00", grpc_status:14, grpc_message:"recvmsg:Connection reset by peer"}"
>
2025-12-04 21:06:18,901 - DEBUG - ydb.connection.2675766  - _rpc_error_handler: RpcState(ExecuteQuery, 7b9e5633-985b-4be3-b8a6-24f594a7f7e8, ghrun-if77zlumgq.auto.internal:8270): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer  {file:"contrib/libs/grpc/src/core/lib/surface/call.cc", file_line:1211, created_time:"2025-12-04T21:06:18.878109786+00:00", grpc_status:14, grpc_message:"recvmsg:Connection reset by peer"}"
>
2025-12-04 21:06:18,915 - DEBUG - ydb.query.pool.2675766  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTNmZGZlZDUtMTE1ZTZkY2EtNWRhNTNmNC02NWZjYjQwOA==
2025-12-04 21:06:18,902 - DEBUG - ydb.connection.2675766  - _rpc_error_handler: RpcState(ExecuteQuery, 341c93ac-0eb8-466e-a1d6-866dc5ce4cee, ghrun-if77zlumgq.auto.internal:8270): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer  {grpc_message:"recvmsg:Connection reset by peer", grpc_status:14, created_time:"2025-12-04T21:06:18.878053089+00:00", file_line:1211, file:"contrib/libs/grpc/src/core/lib/surface/call.cc"}"
>
2025-12-04 21:06:18,903 - DEBUG - ydb.connection.2675766  - _rpc_error_handler: RpcState(ExecuteQuery, 634175a4-c8e0-4f6b-8cc4-05dcca2d4b7b, ghrun-if77zlumgq.auto.internal:8270): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer  {grpc_message:"recvmsg:Connection reset by peer", grpc_status:14, created_time:"2025-12-04T21:06:18.878180555+00:00", file_line:1211, file:"contrib/libs/grpc/src/core/lib/surface/call.cc"}"
>
2025-12-04 21:06:18,904 - DEBUG - ydb.connection.2675766  - _rpc_error_handler: RpcState(AttachSession, 9ecf1589-8564-462e-8b78-8788450531ad, ghrun-if77zlumgq.auto.internal:8270): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer ipv4:127.0.1.1:8270 {file:"contrib/libs/grpc/src/core/lib/surface/call.cc", file_line:1211, created_time:"2025-12-04T21:06:18.878372194+00:00", grpc_status:14, grpc_message:"recvmsg:Connection reset by peer"}"
>
2025-12-04 21:06:18,904 - DEBUG - ydb.connection.2675766  - _rpc_error_handler: RpcState(ExecuteQuery, ebb43b01-91fd-413a-a091-d3c712c43a7c, ghrun-if77zlumgq.auto.internal:8270): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer  {file:"contrib/libs/grpc/src/core/lib/surface/call.cc", file_line:1211, created_time:"2025-12-04T21:06:18.878226172+00:00", grpc_status:14, grpc_message:"recvmsg:Connection reset by peer"}"
>
2025-12-04 21:06:18,913 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint ghrun-if77zlumgq.auto.internal:8270
2025-12-04 21:06:18,908 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:06:18,911 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint ghrun-if77zlumgq.auto.internal:8270
2025-12-04 21:06:18,912 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint ghrun-if77zlumgq.auto.internal:8270
2025-12-04 21:06:18,903 - DEBUG - ydb.connection.2675766  - _rpc_error_handler: RpcState(AttachSession, a4e97bd2-1f99-4d0d-b5fa-47620bafa52f, ghrun-if77zlumgq.auto.internal:8270): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer ipv4:127.0.1.1:8270 {file:"contrib/libs/grpc/src/core/lib/surface/call.cc", file_line:1211, created_time:"2025-12-04T21:06:18.878242555+00:00", grpc_status:14, grpc_message:"recvmsg:Connection reset by peer"}"
>
2025-12-04 21:06:18,912 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint ghrun-if77zlumgq.auto.internal:8270
2025-12-04 21:06:18,920 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint ghrun-if77zlumgq.auto.internal:8270
2025-12-04 21:06:18,932 - DEBUG - ydb.query.pool.2675766  - release: Session returned to queue: ydb://session/3?node_id=1&id=M2JjNWViMGEtNDgyZGUyYjUtMmRiZDdmOTctMTZhOWJhZjg=
2025-12-04 21:06:18,915 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint ghrun-if77zlumgq.auto.internal:8270
2025-12-04 21:06:18,897 - DEBUG - ydb.connection.2675766  - _rpc_error_handler: RpcState(AttachSession, 8c65ce1e-ce30-4b2e-bb8a-88ec24617898, ghrun-if77zlumgq.auto.internal:8270): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer ipv4:127.0.1.1:8270 {grpc_message:"recvmsg:Connection reset by peer", grpc_status:14, created_time:"2025-12-04T21:06:18.878301385+00:00", file_line:1211, file:"contrib/libs/grpc/src/core/lib/surface/call.cc"}"
>
2025-12-04 21:06:18,931 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint ghrun-if77zlumgq.auto.internal:8270
2025-12-04 21:06:18,916 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint ghrun-if77zlumgq.auto.internal:8270
2025-12-04 21:06:18,917 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint ghrun-if77zlumgq.auto.internal:8270
2025-12-04 21:06:18,919 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint ghrun-if77zlumgq.auto.internal:8270
2025-12-04 21:06:18,901 - DEBUG - ydb.connection.2675766  - _rpc_error_handler: RpcState(ExecuteQuery, 6ead9e87-a51d-4084-9019-10500ee89ac9, ghrun-if77zlumgq.auto.internal:8270): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer  {file:"contrib/libs/grpc/src/core/lib/surface/call.cc", file_line:1211, created_time:"2025-12-04T21:06:18.8782564+00:00", grpc_status:14, grpc_message:"recvmsg:Connection reset by peer"}"
>
2025-12-04 21:06:18,921 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint ghrun-if77zlumgq.auto.internal:8270
2025-12-04 21:06:18,908 - DEBUG - ydb.connection.2675766  - _rpc_error_handler: RpcState(AttachSession, b5b562cd-e7de-4388-b016-7087e9ab7c03, ghrun-if77zlumgq.auto.internal:8270): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer ipv4:127.0.1.1:8270 {grpc_message:"recvmsg:Connection reset by peer", grpc_status:14, created_time:"2025-12-04T21:06:18.878156631+00:00", file_line:1211, file:"contrib/libs/grpc/src/core/lib/surface/call.cc"}"
>
2025-12-04 21:06:18,922 - DEBUG - ydb.query.pool.2675766  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmM2ODg2OWItODJlNjBlYzUtMzY5MmIwZTQtNjkwZTM0NjE=
2025-12-04 21:06:18,922 - DEBUG - ydb.query.pool.2675766  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTNmZGZlZDUtMTE1ZTZkY2EtNWRhNTNmNC02NWZjYjQwOA==
2025-12-04 21:06:18,930 - DEBUG - ydb.connection.2675766  - channel_factory: 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)]
2025-12-04 21:06:18,907 - DEBUG - ydb.connection.2675766  - _rpc_error_handler: RpcState(AttachSession, 7aae031e-8ac9-41f9-a93f-52617e54f063, ghrun-if77zlumgq.auto.internal:8270): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer ipv4:127.0.1.1:8270 {file:"contrib/libs/grpc/src/core/lib/surface/call.cc", file_line:1211, created_time:"2025-12-04T21:06:18.878341839+00:00", grpc_status:14, grpc_message:"recvmsg:Connection reset by peer"}"
>
2025-12-04 21:06:18,931 - DEBUG - ydb.query.pool.2675766  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU2ZGY3NWQtMzY4YzE1MWUtOTdmZDFhY2YtZDk3ODZlZGM=
2025-12-04 21:06:18,921 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint ghrun-if77zlumgq.auto.internal:8270
2025-12-04 21:06:18,935 - DEBUG - ydb.query.pool.2675766  - release: Session returned to queue: None
2025-12-04 21:06:18,936 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint ghrun-if77zlumgq.auto.internal:8270
2025-12-04 21:06:18,937 - DEBUG - ydb.query.pool.2675766  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDNhOGFjOWMtM2QwMDcxOTgtZDJkOTcyNzktNmIyOWVkNDc=
2025-12-04 21:06:18,937 - DEBUG - ydb.query.pool.2675766  - release: Session returned to queue: None
2025-12-04 21:06:18,937 - DEBUG - ydb.query.pool.2675766  - release: Session returned to queue: None
2025-12-04 21:06:18,937 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint ghrun-if77zlumgq.auto.internal:8270
2025-12-04 21:06:18,938 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint ghrun-if77zlumgq.auto.internal:8270
2025-12-04 21:06:18,939 - DEBUG - ydb.query.pool.2675766  - release: Session returned to queue: None
2025-12-04 21:06:18,957 - DEBUG - ydb.query.pool.2675766  - release: Session returned to queue: None
2025-12-04 21:06:18,947 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint ghrun-if77zlumgq.auto.internal:8270
2025-12-04 21:06:18,948 - DEBUG - ydb.query.pool.2675766  - release: Session returned to queue: None
2025-12-04 21:06:18,939 - DEBUG - ydb.query.pool.2675766  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmM2ODg2OWItODJlNjBlYzUtMzY5MmIwZTQtNjkwZTM0NjE=
2025-12-04 21:06:18,968 - DEBUG - ydb.query.pool.2675766  - release: Session returned to queue: None
2025-12-04 21:06:18,968 - DEBUG - ydb.query.pool.2675766  - acquire: Acquired dead session from queue: None
2025-12-04 21:06:18,970 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 9 < 100, will create new one.
2025-12-04 21:06:18,973 - DEBUG - ydb.query.pool.2675766  - acquire: Acquired dead session from queue: None
2025-12-04 21:06:18,973 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 8 < 100, will create new one.
2025-12-04 21:06:18,973 - DEBUG - ydb.query.pool.2675766  - acquire: Acquired dead session from queue: None
2025-12-04 21:06:18,974 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 7 < 100, will create new one.
2025-12-04 21:06:18,974 - DEBUG - ydb.query.pool.2675766  - acquire: Acquired dead session from queue: None
2025-12-04 21:06:18,975 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 6 < 100, will create new one.
2025-12-04 21:06:18,975 - DEBUG - ydb.query.pool.2675766  - acquire: Acquired dead session from queue: None
2025-12-04 21:06:18,975 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 5 < 100, will create new one.
2025-12-04 21:06:18,981 - DEBUG - ydb.query.pool.2675766  - acquire: Acquired dead session from queue: None
2025-12-04 21:06:18,981 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 4 < 100, will create new one.
2025-12-04 21:06:18,981 - DEBUG - ydb.query.pool.2675766  - acquire: Acquired dead session from queue: None
2025-12-04 21:06:18,982 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 3 < 100, will create new one.
2025-12-04 21:06:18,982 - DEBUG - ydb.query.pool.2675766  - acquire: Acquired dead session from queue: None
2025-12-04 21:06:18,982 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 2 < 100, will create new one.
2025-12-04 21:06:19,985 - DEBUG - ydb.query.pool.2675766  - acquire: Acquired dead session from queue: None
2025-12-04 21:06:19,985 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 1 < 100, will create new one.
2025-12-04 21:06:20,131 - DEBUG - ydb.query.pool.2675766  - acquire: Acquired dead session from queue: None
2025-12-04 21:06:20,131 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:20,344 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:20,647 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:20,670 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:20,687 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:20,825 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:20,829 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:22,165 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:22,841 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:23,182 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:23,513 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:23,748 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:24,037 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:24,224 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:24,642 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:27,128 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:27,257 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:27,941 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:28,832 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:28,948 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint localhost:8270
2025-12-04 21:06:28,966 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:8270". Check endpoint correctness.
2025-12-04 21:06:29,657 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:29,658 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:06:29,658 - DEBUG - ydb.connection.2675766  - channel_factory: 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)]
2025-12-04 21:06:29,708 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:31,891 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:31,947 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:38,720 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:39,662 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint localhost:8270
2025-12-04 21:06:39,823 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:8270". Check endpoint correctness.
2025-12-04 21:06:40,235 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:40,236 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:06:40,236 - DEBUG - ydb.connection.2675766  - channel_factory: 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)]
2025-12-04 21:06:40,496 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:40,708 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:41,181 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:41,337 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:42,314 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:42,494 - DEBUG - ya.test.2675766  - _wait: Process resource usage is not available as process finished before wait4 was called
2025-12-04 21:06:42,494 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2708801) rc: 0
2025-12-04 21:06:42,495 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2708801) elapsed time (sec): 30.187864303588867
2025-12-04 21:06:42,495 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2708801) wtime: 30.191
2025-12-04 21:06:42,495 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2708801) output:
Window	    Txs	Txs/Sec	Retries	Errors	p50(ms)	p95(ms)	p99(ms)	pMax(ms)
1	     20	20	0	0	301	623	627	627
2	    113	113	0	0	60	443	523	539
3	    158	158	0	0	61	86	95	100
4	    150	150	0	0	59	118	153	159
5	    166	166	0	0	58	83	104	108
6	     34	34	0	0	58	71	72	72
7	      0	0	0	636	0	0	0	0
8	      0	0	0	1264	0	0	0	0
9	      0	0	0	1253	0	0	0	0
10	      0	0	0	988	0	0	0	0
11	      0	0	0	1154	0	0	0	0
12	      0	0	0	1005	0	0	0	0
13	      0	0	0	1125	0	0	0	0
14	      0	0	0	851	0	0	0	0
15	      0	0	0	1596	0	0	0	0
16	      0	0	0	1818	0	0	0	0
17	      0	0	0	1299	0	0	0	0
18	      0	0	0	1611	0	0	0	0
19	      0	0	0	1799	0	0	0	0
20	      0	0	0	1706	0	0	0	0
21	      0	0	0	1578	0	0	0	0
22	      0	0	0	1754	0	0	0	0
23	      0	0	0	1487	0	0	0	0
24	      0	0	0	1831	0	0	0	0
25	      0	0	0	1826	0	0	0	0
26	      0	0	0	1691	0	0	0	0
27	      0	0	0	1739	0	0	0	0
28	      0	0	0	1413	0	0	0	0
29	      0	0	0	1481	0	0	0	0
30	      0	0	0	1809	0	0	0	0

Total	    Txs	Txs/Sec	Retries	Errors	p50(ms)	p95(ms)	p99(ms)	pMax(ms)
30	    641	21.3667	0	34714	60	155	539	627

2025-12-04 21:06:42,495 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2708801) errors:

2025-12-04 21:06:42,506 - DEBUG - ya.test.2675766  - _wait: Process resource usage is not available as process finished before wait4 was called
2025-12-04 21:06:42,507 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2708799) rc: 0
2025-12-04 21:06:42,507 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2708799) elapsed time (sec): 30.201119899749756
2025-12-04 21:06:42,507 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2708799) wtime: 30.205
2025-12-04 21:06:42,507 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2708799) output:
Window	    Txs	Txs/Sec	Retries	Errors	p50(ms)	p95(ms)	p99(ms)	pMax(ms)
1	      0	0	0	0	0	0	0	0
2	      0	0	0	10	0	0	0	0
3	      0	0	0	10	0	0	0	0
4	      0	0	0	10	0	0	0	0
5	      0	0	0	10	0	0	0	0
6	      0	0	0	10	0	0	0	0
7	      0	0	0	777	0	0	0	0
8	      0	0	0	1177	0	0	0	0
9	      0	0	0	1242	0	0	0	0
10	      0	0	0	1141	0	0	0	0
11	      0	0	0	977	0	0	0	0
12	      0	0	0	1252	0	0	0	0
13	      0	0	0	1222	0	0	0	0
14	      0	0	0	1069	0	0	0	0
15	      0	0	0	1602	0	0	0	0
16	      0	0	0	1904	0	0	0	0
17	      0	0	0	1463	0	0	0	0
18	      0	0	0	1698	0	0	0	0
19	      0	0	0	1836	0	0	0	0
20	      0	0	0	1766	0	0	0	0
21	      0	0	0	1829	0	0	0	0
22	      0	0	0	1922	0	0	0	0
23	      0	0	0	1653	0	0	0	0
24	      0	0	0	1815	0	0	0	0
25	      0	0	0	1912	0	0	0	0
26	      0	0	0	1805	0	0	0	0
27	      0	0	0	1681	0	0	0	0
28	      0	0	0	1509	0	0	0	0
29	      0	0	0	1593	0	0	0	0
30	      0	0	0	1808	0	0	0	0

Total	    Txs	Txs/Sec	Retries	Errors	p50(ms)	p95(ms)	p99(ms)	pMax(ms)
30	      0	0	0	36703	0	0	0	0

2025-12-04 21:06:42,508 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2708799) errors:

2025-12-04 21:06:42,587 - DEBUG - ya.test.2675766  - _wait: Process resource usage is not available as process finished before wait4 was called
2025-12-04 21:06:42,588 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2708795) rc: 0
2025-12-04 21:06:42,588 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2708795) elapsed time (sec): 30.28338098526001
2025-12-04 21:06:42,589 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2708795) wtime: 30.288
2025-12-04 21:06:42,589 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2708795) output:
Window	    Txs	Txs/Sec	Retries	Errors	p50(ms)	p95(ms)	p99(ms)	pMax(ms)
1	     10	10	0	0	683	863	863	863
2	     90	90	0	0	80	547	607	619
3	    115	115	0	0	82	112	126	128
4	    115	115	0	0	79	141	169	178
5	    121	121	0	0	79	109	124	131
6	     26	26	0	0	80	97	102	102
7	      0	0	0	757	0	0	0	0
8	      0	0	0	1183	0	0	0	0
9	      0	0	0	1101	0	0	0	0
10	      0	0	0	1103	0	0	0	0
11	      0	0	0	1137	0	0	0	0
12	      0	0	0	1178	0	0	0	0
13	      0	0	0	1236	0	0	0	0
14	      0	0	0	1141	0	0	0	0
15	      0	0	0	1673	0	0	0	0
16	      0	0	0	1890	0	0	0	0
17	      0	0	0	1484	0	0	0	0
18	      0	0	0	1773	0	0	0	0
19	      0	0	0	1828	0	0	0	0
20	      0	0	0	1766	0	0	0	0
21	      0	0	0	1766	0	0	0	0
22	      0	0	0	1843	0	0	0	0
23	      0	0	0	1667	0	0	0	0
24	      0	0	0	1867	0	0	0	0
25	      0	0	0	1895	0	0	0	0
26	      0	0	0	1815	0	0	0	0
27	      0	0	0	1784	0	0	0	0
28	      0	0	0	1485	0	0	0	0
29	      0	0	0	1725	0	0	0	0
30	      0	0	0	1836	0	0	0	0

Total	    Txs	Txs/Sec	Retries	Errors	p50(ms)	p95(ms)	p99(ms)	pMax(ms)
30	    477	15.9	0	36933	80	178	683	863

2025-12-04 21:06:42,589 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2708795) errors:

2025-12-04 21:06:43,612 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:50,239 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint localhost:8270
2025-12-04 21:06:50,374 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:8270". Check endpoint correctness.
2025-12-04 21:06:51,461 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:06:51,461 - DEBUG - ydb.connection.2675766  - channel_factory: 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)]
2025-12-04 21:06:56,796 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:59,105 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:06:59,830 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:07:00,154 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:07:00,254 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:07:01,464 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint localhost:8270
2025-12-04 21:07:01,593 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:8270". Check endpoint correctness.
2025-12-04 21:07:03,069 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:07:03,070 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:07:03,070 - DEBUG - ydb.connection.2675766  - channel_factory: 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)]
2025-12-04 21:07:03,241 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:07:06,915 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:07:13,073 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint localhost:8270
2025-12-04 21:07:13,206 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:8270". Check endpoint correctness.
2025-12-04 21:07:14,395 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:07:14,396 - DEBUG - ydb.connection.2675766  - channel_factory: 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)]
2025-12-04 21:07:24,399 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint localhost:8270
2025-12-04 21:07:24,546 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:8270". Check endpoint correctness.
2025-12-04 21:07:26,027 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:07:26,027 - DEBUG - ydb.connection.2675766  - channel_factory: 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)]
2025-12-04 21:07:36,030 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint localhost:8270
2025-12-04 21:07:36,185 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:8270". Check endpoint correctness.
2025-12-04 21:07:37,113 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:07:37,117 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:07:37,117 - DEBUG - ydb.connection.2675766  - channel_factory: 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)]
2025-12-04 21:07:45,672 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:07:47,121 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint localhost:8270
2025-12-04 21:07:47,277 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:8270". Check endpoint correctness.
2025-12-04 21:07:48,957 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:07:48,957 - DEBUG - ydb.connection.2675766  - channel_factory: 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)]
2025-12-04 21:07:49,243 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:07:50,546 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:07:52,494 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:07:57,157 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:07:58,961 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint localhost:8270
2025-12-04 21:07:59,117 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:8270". Check endpoint correctness.
2025-12-04 21:07:59,370 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:07:59,370 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:07:59,371 - DEBUG - ydb.connection.2675766  - channel_factory: 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)]
2025-12-04 21:08:00,675 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:08:09,374 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint localhost:8270
2025-12-04 21:08:09,537 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:8270". Check endpoint correctness.
2025-12-04 21:08:10,869 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:08:10,869 - DEBUG - ydb.connection.2675766  - channel_factory: 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)]
2025-12-04 21:08:17,651 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:08:20,877 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint localhost:8270
2025-12-04 21:08:21,038 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:8270". Check endpoint correctness.
2025-12-04 21:08:22,118 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:08:22,119 - DEBUG - ydb.connection.2675766  - channel_factory: 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)]
2025-12-04 21:08:22,598 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:08:32,122 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint localhost:8270
2025-12-04 21:08:32,279 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:8270". Check endpoint correctness.
2025-12-04 21:08:33,517 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:08:33,518 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:08:33,518 - DEBUG - ydb.connection.2675766  - channel_factory: 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)]
2025-12-04 21:08:43,525 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint localhost:8270
2025-12-04 21:08:43,679 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:8270". Check endpoint correctness.
2025-12-04 21:08:45,409 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:08:45,409 - DEBUG - ydb.connection.2675766  - channel_factory: 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)]
2025-12-04 21:08:46,261 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:08:47,297 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:08:48,653 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:08:52,082 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:08:54,261 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:08:55,413 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint localhost:8270
2025-12-04 21:08:55,571 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:8270". Check endpoint correctness.
2025-12-04 21:08:57,213 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:08:57,213 - DEBUG - ydb.connection.2675766  - channel_factory: 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)]
2025-12-04 21:09:07,216 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint localhost:8270
2025-12-04 21:09:07,381 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:8270". Check endpoint correctness.
2025-12-04 21:09:08,882 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:09:08,883 - DEBUG - ydb.connection.2675766  - channel_factory: 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)]
2025-12-04 21:09:10,929 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:09:15,069 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:09:18,893 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint localhost:8270
2025-12-04 21:09:18,916 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:8270". Check endpoint correctness.
2025-12-04 21:09:20,066 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:09:20,067 - DEBUG - ydb.connection.2675766  - channel_factory: 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)]
2025-12-04 21:09:24,552 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:09:30,114 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint localhost:8270
2025-12-04 21:09:30,145 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:8270". Check endpoint correctness.
2025-12-04 21:09:31,473 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:09:31,515 - DEBUG - ydb.connection.2675766  - channel_factory: 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)]
2025-12-04 21:09:32,466 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:09:41,518 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint localhost:8270
2025-12-04 21:09:41,691 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:8270". Check endpoint correctness.
2025-12-04 21:09:42,819 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:09:42,821 - DEBUG - ydb.connection.2675766  - channel_factory: 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)]
2025-12-04 21:09:47,027 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:09:49,225 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:09:49,904 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:09:50,136 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:09:52,824 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint localhost:8270
2025-12-04 21:09:52,997 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:8270". Check endpoint correctness.
2025-12-04 21:09:53,088 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:09:53,089 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:09:53,090 - DEBUG - ydb.connection.2675766  - channel_factory: 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)]
2025-12-04 21:10:03,092 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint localhost:8270
2025-12-04 21:10:03,279 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:8270". Check endpoint correctness.
2025-12-04 21:10:03,364 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:10:03,368 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:10:03,386 - DEBUG - ydb.connection.2675766  - channel_factory: 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)]
2025-12-04 21:10:05,917 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:10:13,402 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint localhost:8270
2025-12-04 21:10:13,556 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:8270". Check endpoint correctness.
2025-12-04 21:10:15,371 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:10:15,371 - DEBUG - ydb.connection.2675766  - channel_factory: 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)]
2025-12-04 21:10:15,596 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:10:21,929 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:10:25,375 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint localhost:8270
2025-12-04 21:10:25,537 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:8270". Check endpoint correctness.
2025-12-04 21:10:27,427 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:10:27,435 - DEBUG - ydb.connection.2675766  - channel_factory: 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)]
2025-12-04 21:10:37,441 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint localhost:8270
2025-12-04 21:10:37,453 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:8270". Check endpoint correctness.
2025-12-04 21:10:39,343 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:10:39,365 - DEBUG - ydb.connection.2675766  - channel_factory: 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)]
2025-12-04 21:10:41,345 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:10:41,506 - DEBUG - ydb.query.pool.2675766  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:10:42,392 - ERROR - ya.test.2675766  - logreport: ydb/tests/olap/test_log_scenario.py:235: in test_log_uniform
    thread.join()
ydb/tests/olap/common/thread_helper.py:18: in join
    raise self.exc
ydb/tests/olap/common/thread_helper.py:11: in run
    self.ret = self._target(*self._args, **self._kwargs)
ydb/tests/olap/test_log_scenario.py:147: in aggregation_query
    self.ydb_client.query(f"SELECT COUNT(*) FROM `{self.table_name}` ")
ydb/tests/olap/common/ydb_client.py:24: in query
    return self.session_pool.execute_with_retries(query=statement, settings=request_settings)
contrib/python/ydb/py3/ydb/query/pool.py:252: in execute_with_retries
    return retry_operation_sync(wrapped_callee, retry_settings)
contrib/python/ydb/py3/ydb/retries.py:135: in retry_operation_sync
    for next_opt in opt_generator:
contrib/python/ydb/py3/ydb/retries.py:130: in retry_operation_impl
    raise status
contrib/python/ydb/py3/ydb/retries.py:96: in retry_operation_impl
    result = YdbRetryOperationFinalResult(callee(*args, **kwargs))
contrib/python/ydb/py3/ydb/query/pool.py:248: in wrapped_callee
    with self.checkout(timeout=retry_settings.max_session_acquire_timeout) as session:
contrib/python/ydb/py3/ydb/query/pool.py:331: in __enter__
    self._session = self._pool.acquire(self._timeout)
contrib/python/ydb/py3/ydb/query/pool.py:111: in acquire
    session = self._create_new_session(time_left)
contrib/python/ydb/py3/ydb/query/pool.py:63: in _create_new_session
    session.create(settings=BaseRequestSettings().with_timeout(timeout))
contrib/python/ydb/py3/ydb/query/session.py:307: in create
    self._create_call(settings=settings)
contrib/python/ydb/py3/ydb/query/session.py:171: in _create_call
    return self._driver(
contrib/python/ydb/py3/ydb/tracing.py:70: in wrapper
    return f(self, *args, **kwargs)
contrib/python/ydb/py3/ydb/pool.py:459: in __call__
    connection = self._store.get(preferred_endpoint)
contrib/python/ydb/py3/ydb/tracing.py:70: in wrapper
    return f(self, *args, **kwargs)
contrib/python/ydb/py3/ydb/pool.py:144: in get
    raise issues.ConnectionLost("Couldn't find valid connection")
E   ydb.issues.ConnectionLost: Couldn't find valid connection
2025-12-04 21:10:42,433 - INFO - ya.test.2675766  - pytest_runtest_teardown: Test teardown
2025-12-04 21:10:42,434 - DEBUG - ydb.query.pool.2675766  - stop: All session were deleted.
2025-12-04 21:10:42,469 - DEBUG - ydb.topic.2675766  - close: Close topic client
2025-12-04 21:10:42,551 - DEBUG - ydb.topic.2675766  - close: Topic client was closed
2025-12-04 21:10:42,551 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint localhost:8270
2025-12-04 21:10:49,374 - DEBUG - ydb.connection.2675766  - close: Closing channel for endpoint localhost:8270
2025-12-04 21:10:49,397 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2675766  - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:8270". Check endpoint correctness.
2025-12-04 21:10:49,397 - INFO - ydb.pool.Discovery.2675766  - run: Successfully terminated discovery process
2025-12-04 21:10:49,399 - DEBUG - library.python.cores.2675766  - recover_core_dump_file: hostname = 'ghrun-if77zlumgq'
2025-12-04 21:10:49,400 - DEBUG - library.python.cores.2675766  - recover_core_dump_file: rlimit_core = '(0, 0)'
2025-12-04 21:10:49,401 - DEBUG - library.python.cores.2675766  - recover_core_dump_file: core_pattern = '|/usr/share/apport/apport -p%p -s%s -c%c -d%d -P%P -u%u -g%g -F%F -- %E'
2025-12-04 21:10:49,401 - DEBUG - library.python.cores.2675766  - recover_core_dump_file: core_uses_pid = '1'
2025-12-04 21:10:49,402 - DEBUG - library.python.cores.2675766  - recover_core_dump_file: Core dump dir (/home/runner/.ya/build/build_root/6mdl/004303/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_log_scenario.py.TestLogScenario.test_log_uniform/cluster/node_1) permission mask: 0o40755 (expected: 0o41777 (0o40000-dir, 0o1000-sticky bit))
2025-12-04 21:10:49,403 - DEBUG - library.python.cores.2675766  - recover_core_dump_file: Search for core dump files match pattern 'core.2679321' in '/home/runner/.ya/build/build_root/6mdl/004303/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_log_scenario.py.TestLogScenario.test_log_uniform/cluster/node_1'
2025-12-04 21:10:49,403 - DEBUG - library.python.cores.2675766  - recover_core_dump_file: Matched core dump files (0/3): [] (mismatched samples: stderr, stdout, logfile_ynkpzlri.log)
2025-12-04 21:10:49,403 - WARNING - library.python.cores.2675766  - recover_core_dump_file: Core dump dir doesn't exist: /coredumps
2025-12-04 21:10:49,404 - WARNING - library.python.cores.2675766  - recover_core_dump_file: Core dump dir doesn't exist: /var/tmp/cores
2025-12-04 21:10:49,405 - INFO - ydb.tests.library.harness.kikimr_runner.2675766  - stop: Stopped node localhost:8270/1
2025-12-04 21:10:49,409 - DEBUG - library.python.filelock.2675766  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/62397
2025-12-04 21:10:49,409 - DEBUG - library.python.filelock.2675766  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/1081
2025-12-04 21:10:49,409 - DEBUG - library.python.filelock.2675766  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/31090
2025-12-04 21:10:49,409 - DEBUG - library.python.filelock.2675766  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/8270
2025-12-04 21:10:49,410 - DEBUG - library.python.filelock.2675766  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/23166
2025-12-04 21:10:49,536 - ERROR - ya.test.2675766  - logreport: ydb/tests/olap/test_log_scenario.py:123: in teardown_class
    cls.cluster.stop()
ydb/tests/library/harness/kikimr_runner.py:707: 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 = -6.
E   Stdout file name: 
E   /home/runner/.ya/build/build_root/6mdl/004303/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_log_scenario.py.TestLogScenario.test_log_uniform/cluster/node_1/stdout
E   Stderr file name: 
E   /home/runner/.ya/build/build_root/6mdl/004303/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_log_scenario.py.TestLogScenario.test_log_uniform/cluster/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   VERIFY failed (2025-12-04T21:06:12.837460Z): source_id=226;tablet_id=72075186224037897;verification=lhs.type_id() == rhs.type_id();fline=compare.h:82;
E   ydb/library/actors/core/log.cpp:857
E   ~TVerifyFormattedRecordWriter(): requirement false failed
E   0. /-S/util/system/yassert.cpp:86: InternalPanicImpl @ 0xA948AC5
E   1. /-S/util/system/yassert.cpp:55: Panic @ 0xA940F56
E   2. /tmp//-S/ydb/library/actors/core/log.cpp:857: ~TVerifyFormattedRecordWriter @ 0xB7D9118
E   3. /-S/ydb/library/formats/arrow/switch/compare.h:82: TypedCompare<false> @ 0xD76262B
E   4. /-S/ydb/core/formats/arrow/reader/position.h:85: CompareImpl @ 0x9F9FC68
E   5. /-S/ydb/core/formats/arrow/reader/position.h:482: Compare @ 0x9F9F9BF
E   6. /tmp//-S/ydb/core/formats/arrow/reader/position.cpp:36: FindBound @ 0xD73C51D
E   7. /tmp//-S/ydb/core/tx/columnshard/engines/predicate/filter.cpp:22: BuildFilter @ 0x1440390B
E   8. /tmp//-S/ydb/core/tx/columnshard/engines/reader/simple_reader/iterator/fetching.cpp:16: DoExecuteInplace @ 0x1504A9D7
E   9. /-S/ydb/core/tx/columnshard/engines/reader/common_reader/common/script.h:47: ExecuteInplace @ 0x14F9F793
E   10. /tmp//-S/ydb/core/tx/columnshard/engines/reader/common_reader/common/script_cursor.cpp:36: Execute @ 0x14F9F793
E   11. /tmp//-S/ydb/core/tx/columnshard/engines/reader/common_reader/iterator/fetching.cpp:30: DoExecuteImpl @ 0x14F9D143
E   12. /tmp//-S/ydb/core/tx/columnshard/engines/reader/common/conveyor_task.cpp:8: DoExecute @ 0x14FA0B07
E   13. /tmp//-S/ydb/core/tx/conveyor/usage/abstract.cpp:16: Execute @ 0x144216F8
E   14. /tmp//-S/ydb/core/tx/conveyor_composite/service/worker.cpp:17: ExecuteTask @ 0x1D071FC5
E   15. /tmp//-S/ydb/library/actors/core/actor.cpp:350: Receive @ 0xB77B197
E   16. /tmp//-S/ydb/library/actors/core/executor_thread.cpp:267: Execute @ 0xB7C9BC4
E   17. /tmp//-S/ydb/library/actors/core/executor_thread.cpp:455: operator() @ 0xB7CDC84
E   18. /tmp//-S/ydb/library/actors/core/executor_thread.cpp:507: ProcessExecutorPool @ 0xB7CD890
E   19. /tmp//-S/ydb/library/actors/core/executor_thread.cpp:533: ThreadProc @ 0xB7CE47E
E   20. /-S/util/system/thread.cpp:245: ThreadProxy @ 0xA94A71C
E   21. ??:0: ?? @ 0x7FABEF1A0AC2
E   22. ??:0: ?? @ 0x7FABEF2328BF
2025-12-04 21:10:55,356 - ERROR - ydb.query.pool.2675766  - acquire: An attempt to take session from closed session pool.
2025-12-04 21:11:26,770 - DEBUG - ya.test.2675766  - execute: Executing '['/home/runner/.ya/build/build_root/6mdl/004303/ydb/apps/ydb/ydb', '-e', 'grpc://localhost:8270', '-d', '/Root', 'workload', 'log', '--path', 'log', 'clean']' in 'None' (waiting)
2025-12-04 21:11:26,773 - DEBUG - ya.test.2675766  - execute: Command pid: 2920367
2025-12-04 21:11:26,915 - DEBUG - ya.test.2675766  - _kill_process_tree: Killing process 2920367
2025-12-04 21:11:26,915 - DEBUG - ya.test.2675766  - _nix_kill_process_tree: Killing process tree for pid 2920367 (bin:'error([Errno 2] No such file or directory: '/proc/2920367/exe')')
2025-12-04 21:11:26,916 - DEBUG - ya.test.2675766  - try_to_send_signal: Error while sending signal 19 to pid 2920367: [Errno 3] No such process
2025-12-04 21:11:26,916 - DEBUG - ya.test.2675766  - try_to_send_signal: Error while sending signal 9 to pid 2920367: [Errno 3] No such process
2025-12-04 21:11:26,916 - DEBUG - ya.test.2675766  - try_to_send_signal: Error while sending signal 18 to pid 2920367: [Errno 3] No such process
2025-12-04 21:11:26,916 - DEBUG - ya.test.2675766  - _wait: Process resource usage is not available as process finished before wait4 was called
2025-12-04 21:11:26,929 - DEBUG - ya.test.2675766  - wait: Command exception: sys.meta_path is None, Python is likely shutting down
2025-12-04 21:11:26,936 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2920367) rc: 0
2025-12-04 21:11:26,936 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2920367) elapsed time (sec): 0.16244173049926758
2025-12-04 21:11:26,943 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2920367) wtime: 0.158
2025-12-04 21:11:26,944 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2920367) output:
Remove path log...

2025-12-04 21:11:26,944 - DEBUG - ya.test.2675766  - _save_outputs: Command (pid 2920367) errors:
Status: TRANSPORT_UNAVAILABLE
Issues: 
<main>: Error: GRpc error: (14): connections to all backends failing; last error: UNKNOWN: ipv4:127.0.0.1:8270: Failed to connect to remote host: Connection refused
<main>: Error: Grpc error response on endpoint localhost:8270
<main>: Error: Endpoint list is empty for database /Root, cluster endpoint localhost:8270.

