2025-11-10 10:07:06,483 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-10 10:07:06,483 - INFO - ya.test - pytest_runtest_setup: test_overloads_workload[2-10000]
2025-11-10 10:07:06,483 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-10 10:07:06,483 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-10 10:07:06,485 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_overloads.py::TestLogScenario, test_name: test_overloads_workload[2-10000])
2025-11-10 10:07:06,486 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.11
2025-11-10 10:07:06,487 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.11
2025-11-10 10:07:06,487 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/6t6o/0024d8/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-10 10:07:06,488 - DEBUG - ya.test - execute: Command pid: 2166223
2025-11-10 10:07:06,952 - DEBUG - ya.test - _save_outputs: Command (pid 2166223) rc: 0
2025-11-10 10:07:06,952 - DEBUG - ya.test - _save_outputs: Command (pid 2166223) elapsed time (sec): 0.4446909427642822
2025-11-10 10:07:06,975 - DEBUG - ya.test - _save_outputs: Command (pid 2166223) idrss: 0
2025-11-10 10:07:06,976 - DEBUG - ya.test - _save_outputs: Command (pid 2166223) inblock: 0
2025-11-10 10:07:06,976 - DEBUG - ya.test - _save_outputs: Command (pid 2166223) isrss: 0
2025-11-10 10:07:06,981 - DEBUG - ya.test - _save_outputs: Command (pid 2166223) ixrss: 0
2025-11-10 10:07:06,987 - DEBUG - ya.test - _save_outputs: Command (pid 2166223) majflt: 0
2025-11-10 10:07:06,987 - DEBUG - ya.test - _save_outputs: Command (pid 2166223) maxrss: 541020
2025-11-10 10:07:06,987 - DEBUG - ya.test - _save_outputs: Command (pid 2166223) minflt: 16172
2025-11-10 10:07:06,987 - DEBUG - ya.test - _save_outputs: Command (pid 2166223) msgrcv: 0
2025-11-10 10:07:06,987 - DEBUG - ya.test - _save_outputs: Command (pid 2166223) msgsnd: 0
2025-11-10 10:07:06,987 - DEBUG - ya.test - _save_outputs: Command (pid 2166223) nivcsw: 22
2025-11-10 10:07:06,988 - DEBUG - ya.test - _save_outputs: Command (pid 2166223) nsignals: 0
2025-11-10 10:07:06,988 - DEBUG - ya.test - _save_outputs: Command (pid 2166223) nswap: 0
2025-11-10 10:07:06,988 - DEBUG - ya.test - _save_outputs: Command (pid 2166223) nvcsw: 16
2025-11-10 10:07:06,988 - DEBUG - ya.test - _save_outputs: Command (pid 2166223) oublock: 8
2025-11-10 10:07:06,988 - DEBUG - ya.test - _save_outputs: Command (pid 2166223) stime: 0.241508
2025-11-10 10:07:06,988 - DEBUG - ya.test - _save_outputs: Command (pid 2166223) utime: 0.13857
2025-11-10 10:07:06,989 - DEBUG - ya.test - _save_outputs: Command (pid 2166223) wtime: 0.446
2025-11-10 10:07:06,989 - DEBUG - ya.test - _save_outputs: Command (pid 2166223) output:
Git info:
    Commit: 2d3bc32bffc01725fa6c3dd0bb0f7616ee098760
    Branch: 
    Author: Daniil Timižev <ditimizhev@ydb.tech>
    Summary: Merge 4ff3894868fb9bba81a268efd022ca68496f230a into 27b8fe5960eec979164acf2636986bcea3ca729d

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

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

2025-11-10 10:07:06,989 - DEBUG - ya.test - _save_outputs: Command (pid 2166223) errors:

2025-11-10 10:07:06,989 - INFO - __tests__.test_overloads - _setup_ydb: Git info:
    Commit: 2d3bc32bffc01725fa6c3dd0bb0f7616ee098760
    Branch: 
    Author: Daniil Timižev <ditimizhev@ydb.tech>
    Summary: Merge 4ff3894868fb9bba81a268efd022ca68496f230a into 27b8fe5960eec979164acf2636986bcea3ca729d

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

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

2025-11-10 10:07:07,051 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/6t6o/0024d8/ydb/apps/ydbd/ydbd
2025-11-10 10:07:07,058 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/4640
2025-11-10 10:07:07,065 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/6t6o/0024d8/r3tmp/kikimr_cluster_h0sk4gdd
2025-11-10 10:07:07,102 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/6t6o/0024d8/ydb/apps/ydbd/ydbd
2025-11-10 10:07:07,102 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/28238
2025-11-10 10:07:07,103 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/4500
2025-11-10 10:07:07,103 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18288
2025-11-10 10:07:07,104 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/10253
2025-11-10 10:07:07,110 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/6t6o/0024d8/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/test_overloads.py.TestLogScenario.test_overloads_workload.2-10000/cluster/kikimr_configs"
2025-11-10 10:07:07,120 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/6t6o/0024d8/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/6t6o/0024d8/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/test_overloads.py.TestLogScenario.test_overloads_workload.2-10000/cluster/node_1/logfile_krm4orxd.log --grpc-port=28238 --mon-port=4500 --ic-port=4640
2025-11-10 10:07:07,123 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:28238/1, disk_size 68719476736
2025-11-10 10:07:07,126 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/6t6o/0024d8/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/test_overloads.py.TestLogScenario.test_overloads_workload.2-10000/cluster/kikimr_configs"
2025-11-10 10:07:07,155 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/6t6o/0024d8/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/6t6o/0024d8/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/test_overloads.py.TestLogScenario.test_overloads_workload.2-10000/cluster/node_1/logfile_krm4orxd.log --grpc-port=28238 --mon-port=4500 --ic-port=4640
2025-11-10 10:07:07,185 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/6t6o/0024d8/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/6t6o/0024d8/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/test_overloads.py.TestLogScenario.test_overloads_workload.2-10000/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/6t6o/0024d8/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/test_overloads.py.TestLogScenario.test_overloads_workload.2-10000/cluster/node_1/logfile_krm4orxd.log', '--grpc-port=28238', '--mon-port=4500', '--ic-port=4640')' in '/home/runner/.ya/build/build_root/6t6o/0024d8/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/test_overloads.py.TestLogScenario.test_overloads_workload.2-10000/cluster/node_1' (no wait)
2025-11-10 10:07:07,207 - DEBUG - ya.test - execute: Command pid: 2166412
2025-11-10 10:07:07,208 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:28238/1
2025-11-10 10:07:07,217 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.12
2025-11-10 10:07:07,218 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.12
2025-11-10 10:07:07,218 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/6t6o/0024d8/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-10 10:07:07,219 - DEBUG - ya.test - execute: Command pid: 2166445
2025-11-10 10:07:07,698 - DEBUG - ya.test - _save_outputs: Command (pid 2166445) rc: 0
2025-11-10 10:07:07,698 - DEBUG - ya.test - _save_outputs: Command (pid 2166445) elapsed time (sec): 0.469632625579834
2025-11-10 10:07:07,699 - DEBUG - ya.test - _save_outputs: Command (pid 2166445) idrss: 0
2025-11-10 10:07:07,699 - DEBUG - ya.test - _save_outputs: Command (pid 2166445) inblock: 0
2025-11-10 10:07:07,699 - DEBUG - ya.test - _save_outputs: Command (pid 2166445) isrss: 0
2025-11-10 10:07:07,699 - DEBUG - ya.test - _save_outputs: Command (pid 2166445) ixrss: 0
2025-11-10 10:07:07,699 - DEBUG - ya.test - _save_outputs: Command (pid 2166445) majflt: 0
2025-11-10 10:07:07,700 - DEBUG - ya.test - _save_outputs: Command (pid 2166445) maxrss: 541028
2025-11-10 10:07:07,700 - DEBUG - ya.test - _save_outputs: Command (pid 2166445) minflt: 16172
2025-11-10 10:07:07,700 - DEBUG - ya.test - _save_outputs: Command (pid 2166445) msgrcv: 0
2025-11-10 10:07:07,700 - DEBUG - ya.test - _save_outputs: Command (pid 2166445) msgsnd: 0
2025-11-10 10:07:07,719 - DEBUG - ya.test - _save_outputs: Command (pid 2166445) nivcsw: 9
2025-11-10 10:07:07,719 - DEBUG - ya.test - _save_outputs: Command (pid 2166445) nsignals: 0
2025-11-10 10:07:07,720 - DEBUG - ya.test - _save_outputs: Command (pid 2166445) nswap: 0
2025-11-10 10:07:07,720 - DEBUG - ya.test - _save_outputs: Command (pid 2166445) nvcsw: 17
2025-11-10 10:07:07,720 - DEBUG - ya.test - _save_outputs: Command (pid 2166445) oublock: 8
2025-11-10 10:07:07,720 - DEBUG - ya.test - _save_outputs: Command (pid 2166445) stime: 0.268773
2025-11-10 10:07:07,720 - DEBUG - ya.test - _save_outputs: Command (pid 2166445) utime: 0.122529
2025-11-10 10:07:07,721 - DEBUG - ya.test - _save_outputs: Command (pid 2166445) wtime: 0.471
2025-11-10 10:07:07,721 - DEBUG - ya.test - _save_outputs: Command (pid 2166445) output:
Git info:
    Commit: 2d3bc32bffc01725fa6c3dd0bb0f7616ee098760
    Branch: 
    Author: Daniil Timižev <ditimizhev@ydb.tech>
    Summary: Merge 4ff3894868fb9bba81a268efd022ca68496f230a into 27b8fe5960eec979164acf2636986bcea3ca729d

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

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

2025-11-10 10:07:07,721 - DEBUG - ya.test - _save_outputs: Command (pid 2166445) errors:

2025-11-10 10:07:07,722 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 2d3bc32bffc01725fa6c3dd0bb0f7616ee098760
    Branch: 
    Author: Daniil Timižev <ditimizhev@ydb.tech>
    Summary: Merge 4ff3894868fb9bba81a268efd022ca68496f230a into 27b8fe5960eec979164acf2636986bcea3ca729d
2025-11-10 10:07:09,668 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/6t6o/0024d8/ydb/apps/ydbd/ydbd
2025-11-10 10:07:09,673 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/6t6o/0024d8/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:28238', '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: 4640\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-10 10:07:09,676 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.13
2025-11-10 10:07:09,677 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.13
2025-11-10 10:07:09,678 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/6t6o/0024d8/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:28238', '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: 4640\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-10 10:07:09,679 - DEBUG - ya.test - execute: Command pid: 2168302
2025-11-10 10:07:10,124 - DEBUG - ya.test - _save_outputs: Command (pid 2168302) rc: 0
2025-11-10 10:07:10,124 - DEBUG - ya.test - _save_outputs: Command (pid 2168302) elapsed time (sec): 0.4228343963623047
2025-11-10 10:07:10,125 - DEBUG - ya.test - _save_outputs: Command (pid 2168302) idrss: 0
2025-11-10 10:07:10,125 - DEBUG - ya.test - _save_outputs: Command (pid 2168302) inblock: 0
2025-11-10 10:07:10,125 - DEBUG - ya.test - _save_outputs: Command (pid 2168302) isrss: 0
2025-11-10 10:07:10,125 - DEBUG - ya.test - _save_outputs: Command (pid 2168302) ixrss: 0
2025-11-10 10:07:10,125 - DEBUG - ya.test - _save_outputs: Command (pid 2168302) majflt: 0
2025-11-10 10:07:10,125 - DEBUG - ya.test - _save_outputs: Command (pid 2168302) maxrss: 549280
2025-11-10 10:07:10,126 - DEBUG - ya.test - _save_outputs: Command (pid 2168302) minflt: 18315
2025-11-10 10:07:10,126 - DEBUG - ya.test - _save_outputs: Command (pid 2168302) msgrcv: 0
2025-11-10 10:07:10,126 - DEBUG - ya.test - _save_outputs: Command (pid 2168302) msgsnd: 0
2025-11-10 10:07:10,126 - DEBUG - ya.test - _save_outputs: Command (pid 2168302) nivcsw: 11
2025-11-10 10:07:10,126 - DEBUG - ya.test - _save_outputs: Command (pid 2168302) nsignals: 0
2025-11-10 10:07:10,126 - DEBUG - ya.test - _save_outputs: Command (pid 2168302) nswap: 0
2025-11-10 10:07:10,127 - DEBUG - ya.test - _save_outputs: Command (pid 2168302) nvcsw: 130
2025-11-10 10:07:10,127 - DEBUG - ya.test - _save_outputs: Command (pid 2168302) oublock: 8
2025-11-10 10:07:10,127 - DEBUG - ya.test - _save_outputs: Command (pid 2168302) stime: 0.257897
2025-11-10 10:07:10,127 - DEBUG - ya.test - _save_outputs: Command (pid 2168302) utime: 0.120889
2025-11-10 10:07:10,127 - DEBUG - ya.test - _save_outputs: Command (pid 2168302) wtime: 0.424
2025-11-10 10:07:10,128 - DEBUG - ya.test - _save_outputs: Command (pid 2168302) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 4

2025-11-10 10:07:10,128 - DEBUG - ya.test - _save_outputs: Command (pid 2168302) errors:

2025-11-10 10:07:10,129 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/6t6o/0024d8/ydb/apps/ydbd/ydbd
2025-11-10 10:07:10,136 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/6t6o/0024d8/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:28238', '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-11-10 10:07:10,149 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.14
2025-11-10 10:07:10,155 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.14
2025-11-10 10:07:10,171 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/6t6o/0024d8/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:28238', '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-11-10 10:07:10,175 - DEBUG - ya.test - execute: Command pid: 2168775
2025-11-10 10:07:10,641 - DEBUG - ya.test - _save_outputs: Command (pid 2168775) rc: 0
2025-11-10 10:07:10,641 - DEBUG - ya.test - _save_outputs: Command (pid 2168775) elapsed time (sec): 0.44504523277282715
2025-11-10 10:07:10,641 - DEBUG - ya.test - _save_outputs: Command (pid 2168775) idrss: 0
2025-11-10 10:07:10,642 - DEBUG - ya.test - _save_outputs: Command (pid 2168775) inblock: 0
2025-11-10 10:07:10,642 - DEBUG - ya.test - _save_outputs: Command (pid 2168775) isrss: 0
2025-11-10 10:07:10,642 - DEBUG - ya.test - _save_outputs: Command (pid 2168775) ixrss: 0
2025-11-10 10:07:10,642 - DEBUG - ya.test - _save_outputs: Command (pid 2168775) majflt: 0
2025-11-10 10:07:10,642 - DEBUG - ya.test - _save_outputs: Command (pid 2168775) maxrss: 549268
2025-11-10 10:07:10,643 - DEBUG - ya.test - _save_outputs: Command (pid 2168775) minflt: 18314
2025-11-10 10:07:10,643 - DEBUG - ya.test - _save_outputs: Command (pid 2168775) msgrcv: 0
2025-11-10 10:07:10,643 - DEBUG - ya.test - _save_outputs: Command (pid 2168775) msgsnd: 0
2025-11-10 10:07:10,643 - DEBUG - ya.test - _save_outputs: Command (pid 2168775) nivcsw: 14
2025-11-10 10:07:10,643 - DEBUG - ya.test - _save_outputs: Command (pid 2168775) nsignals: 0
2025-11-10 10:07:10,643 - DEBUG - ya.test - _save_outputs: Command (pid 2168775) nswap: 0
2025-11-10 10:07:10,646 - DEBUG - ya.test - _save_outputs: Command (pid 2168775) nvcsw: 139
2025-11-10 10:07:10,646 - DEBUG - ya.test - _save_outputs: Command (pid 2168775) oublock: 8
2025-11-10 10:07:10,647 - DEBUG - ya.test - _save_outputs: Command (pid 2168775) stime: 0.285869
2025-11-10 10:07:10,654 - DEBUG - ya.test - _save_outputs: Command (pid 2168775) utime: 0.123082
2025-11-10 10:07:10,654 - DEBUG - ya.test - _save_outputs: Command (pid 2168775) wtime: 0.461
2025-11-10 10:07:10,654 - DEBUG - ya.test - _save_outputs: Command (pid 2168775) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-10 10:07:10,654 - DEBUG - ya.test - _save_outputs: Command (pid 2168775) errors:

2025-11-10 10:07:10,655 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-10 10:07:10,671 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-10 10:07:10,683 - DEBUG - ydb.connection - 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-11-10 10:07:10,695 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-10 10:07:10,696 - DEBUG - ydb.connection - 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-11-10 10:07:10,705 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-10 10:07:10,706 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 5b0c6b73-a52a-4441-b6b7-79eaf4fd4875, localhost:28238): creating call state
2025-11-10 10:07:10,707 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 5b0c6b73-a52a-4441-b6b7-79eaf4fd4875, localhost:28238): request = { database: "/Root" }
2025-11-10 10:07:10,711 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 5b0c6b73-a52a-4441-b6b7-79eaf4fd4875, localhost:28238): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-kipqlopw2q.auto.internal" port: 28238 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-11-10 10:07:10,712 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-kipqlopw2q.auto.internal:28238, location 1, ssl: False>]>
2025-11-10 10:07:10,714 - DEBUG - ydb.connection - 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-11-10 10:07:10,736 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:28238
2025-11-10 10:07:10,737 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/6t6o/0024d8/ydb/apps/ydb/ydb
2025-11-10 10:07:10,738 - INFO - root - _call: YdbWorkloadOverload execute /home/runner/.ya/build/build_root/6t6o/0024d8/ydb/apps/ydb/ydb -e grpc://localhost:28238 -d /Root workload log --path log_2_10000 init --path log_2_10000 --store column --ttl 1000 with wait = True
2025-11-10 10:07:10,742 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.8
2025-11-10 10:07:10,757 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/6t6o/0024d8/ydb/apps/ydb/ydb', '-e', 'grpc://localhost:28238', '-d', '/Root', 'workload', 'log', '--path', 'log_2_10000', 'init', '--path', 'log_2_10000', '--store', 'column', '--ttl', '1000']' in 'None' (waiting)
2025-11-10 10:07:10,759 - DEBUG - ya.test - execute: Command pid: 2169154
2025-11-10 10:07:11,185 - DEBUG - ya.test - _save_outputs: Command (pid 2169154) rc: 0
2025-11-10 10:07:11,185 - DEBUG - ya.test - _save_outputs: Command (pid 2169154) elapsed time (sec): 0.4244384765625
2025-11-10 10:07:11,185 - DEBUG - ya.test - _save_outputs: Command (pid 2169154) idrss: 0
2025-11-10 10:07:11,192 - DEBUG - ya.test - _save_outputs: Command (pid 2169154) inblock: 0
2025-11-10 10:07:11,193 - DEBUG - ya.test - _save_outputs: Command (pid 2169154) isrss: 0
2025-11-10 10:07:11,193 - DEBUG - ya.test - _save_outputs: Command (pid 2169154) ixrss: 0
2025-11-10 10:07:11,193 - DEBUG - ya.test - _save_outputs: Command (pid 2169154) majflt: 0
2025-11-10 10:07:11,193 - DEBUG - ya.test - _save_outputs: Command (pid 2169154) maxrss: 174336
2025-11-10 10:07:11,194 - DEBUG - ya.test - _save_outputs: Command (pid 2169154) minflt: 3541
2025-11-10 10:07:11,194 - DEBUG - ya.test - _save_outputs: Command (pid 2169154) msgrcv: 0
2025-11-10 10:07:11,194 - DEBUG - ya.test - _save_outputs: Command (pid 2169154) msgsnd: 0
2025-11-10 10:07:11,194 - DEBUG - ya.test - _save_outputs: Command (pid 2169154) nivcsw: 25
2025-11-10 10:07:11,194 - DEBUG - ya.test - _save_outputs: Command (pid 2169154) nsignals: 0
2025-11-10 10:07:11,194 - DEBUG - ya.test - _save_outputs: Command (pid 2169154) nswap: 0
2025-11-10 10:07:11,194 - DEBUG - ya.test - _save_outputs: Command (pid 2169154) nvcsw: 187
2025-11-10 10:07:11,195 - DEBUG - ya.test - _save_outputs: Command (pid 2169154) oublock: 8
2025-11-10 10:07:11,195 - DEBUG - ya.test - _save_outputs: Command (pid 2169154) stime: 0.034652999999999996
2025-11-10 10:07:11,195 - DEBUG - ya.test - _save_outputs: Command (pid 2169154) utime: 0.053904999999999995
2025-11-10 10:07:11,195 - DEBUG - ya.test - _save_outputs: Command (pid 2169154) wtime: 0.426
2025-11-10 10:07:11,195 - DEBUG - ya.test - _save_outputs: Command (pid 2169154) output:
None
2025-11-10 10:07:11,196 - DEBUG - ya.test - _save_outputs: Command (pid 2169154) errors:

2025-11-10 10:07:11,196 - INFO - root - _insert_rows: YdbWorkloadOverload bulk_upsert
2025-11-10 10:07:11,196 - INFO - root - _call: YdbWorkloadOverload execute /home/runner/.ya/build/build_root/6t6o/0024d8/ydb/apps/ydb/ydb -e grpc://localhost:28238 -d /Root workload log --path log_2_10000 run bulk_upsert --seconds 60 --threads 10 --rows 10 --quiet with wait = True
2025-11-10 10:07:11,197 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.9
2025-11-10 10:07:11,198 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/6t6o/0024d8/ydb/apps/ydb/ydb', '-e', 'grpc://localhost:28238', '-d', '/Root', 'workload', 'log', '--path', 'log_2_10000', 'run', 'bulk_upsert', '--seconds', '60', '--threads', '10', '--rows', '10', '--quiet']' in 'None' (waiting)
2025-11-10 10:07:11,199 - DEBUG - ya.test - execute: Command pid: 2169371
2025-11-10 10:07:33,385 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-10 10:07:33,385 - DEBUG - ydb.connection - 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-11-10 10:07:33,408 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-10 10:07:33,409 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 83b70b24-6cc5-48c3-8f3f-773918ace48a, localhost:5923): creating call state
2025-11-10 10:07:33,410 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 83b70b24-6cc5-48c3-8f3f-773918ace48a, localhost:5923): request = { database: "/Root" }
2025-11-10 10:07:33,414 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 83b70b24-6cc5-48c3-8f3f-773918ace48a, localhost:5923): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-kipqlopw2q.auto.internal" port: 5923 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-11-10 10:07:33,414 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-kipqlopw2q.auto.internal:5923, location 1, ssl: False>]>
2025-11-10 10:07:33,415 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:5923
2025-11-10 10:07:40,182 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-10 10:07:40,185 - DEBUG - ydb.connection - 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-11-10 10:07:40,189 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-10 10:07:40,190 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 33d64f45-3efa-450c-81b4-a362fdd62695, localhost:5054): creating call state
2025-11-10 10:07:40,193 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 33d64f45-3efa-450c-81b4-a362fdd62695, localhost:5054): request = { database: "/Root" }
2025-11-10 10:07:40,197 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 33d64f45-3efa-450c-81b4-a362fdd62695, localhost:5054): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-kipqlopw2q.auto.internal" port: 5054 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-11-10 10:07:40,198 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-kipqlopw2q.auto.internal:5054, location 1, ssl: False>]>
2025-11-10 10:07:40,198 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:5054
2025-11-10 10:08:12,697 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-10 10:08:12,697 - DEBUG - ydb.connection - 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-11-10 10:08:12,703 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-10 10:08:12,703 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 7b7ab494-8e6c-4f17-bcdd-6cf9029f6935, localhost:28238): creating call state
2025-11-10 10:08:12,704 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 7b7ab494-8e6c-4f17-bcdd-6cf9029f6935, localhost:28238): request = { database: "/Root" }
2025-11-10 10:08:12,706 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 7b7ab494-8e6c-4f17-bcdd-6cf9029f6935, localhost:28238): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-kipqlopw2q.auto.internal" port: 28238 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-11-10 10:08:12,706 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-kipqlopw2q.auto.internal:28238, location 1, ssl: False>]>
2025-11-10 10:08:12,709 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:28238
2025-11-10 10:08:19,791 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-10 10:08:19,796 - DEBUG - ydb.connection - 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-11-10 10:08:19,801 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-10 10:08:19,802 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 4e0cf53e-6e33-4d31-96e8-56c6f0c0fd59, localhost:6808): creating call state
2025-11-10 10:08:19,802 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 4e0cf53e-6e33-4d31-96e8-56c6f0c0fd59, localhost:6808): request = { database: "/Root" }
2025-11-10 10:08:19,811 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 4e0cf53e-6e33-4d31-96e8-56c6f0c0fd59, localhost:6808): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-kipqlopw2q.auto.internal" port: 6808 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-11-10 10:08:19,812 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-kipqlopw2q.auto.internal:6808, location 1, ssl: False>]>
2025-11-10 10:08:19,812 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:6808
2025-11-10 10:08:35,959 - DEBUG - ya.test - _wait: Process resource usage is not available as process finished before wait4 was called
2025-11-10 10:08:35,960 - DEBUG - ya.test - _save_outputs: Command (pid 2169371) rc: 0
2025-11-10 10:08:35,961 - DEBUG - ya.test - _save_outputs: Command (pid 2169371) elapsed time (sec): 84.76085591316223
2025-11-10 10:08:35,961 - DEBUG - ya.test - _save_outputs: Command (pid 2169371) wtime: 84.762
2025-11-10 10:08:35,961 - DEBUG - ya.test - _save_outputs: Command (pid 2169371) output:
None
2025-11-10 10:08:35,961 - DEBUG - ya.test - _save_outputs: Command (pid 2169371) errors:

2025-11-10 10:08:35,962 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-10 10:08:35,964 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, c903bd7a-baf4-418c-b30b-012158dcc07e, ghrun-kipqlopw2q.auto.internal:28238): creating call state
2025-11-10 10:08:35,964 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, c903bd7a-baf4-418c-b30b-012158dcc07e, ghrun-kipqlopw2q.auto.internal:28238): request = {  }
2025-11-10 10:08:35,993 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, c903bd7a-baf4-418c-b30b-012158dcc07e, ghrun-kipqlopw2q.auto.internal:28238): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=YjQzZGRlODUtNjA4YzA4NDEtOTM4ODdjMDItNWYyZWExMWI=" node_id: 1 }
2025-11-10 10:08:35,994 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, 6cae85b3-a96c-43fb-b527-54c79d28f8d9, ghrun-kipqlopw2q.auto.internal:28238): creating call state
2025-11-10 10:08:35,995 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, 6cae85b3-a96c-43fb-b527-54c79d28f8d9, ghrun-kipqlopw2q.auto.internal:28238): request = { session_id: "ydb://session/3?node_id=1&id=YjQzZGRlODUtNjA4YzA4NDEtOTM4ODdjMDItNWYyZWExMWI=" }
2025-11-10 10:08:36,001 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, 6cae85b3-a96c-43fb-b527-54c79d28f8d9, ghrun-kipqlopw2q.auto.internal:28238): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:08:36,013 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=YjQzZGRlODUtNjA4YzA4NDEtOTM4ODdjMDItNWYyZWExMWI=
2025-11-10 10:08:36,021 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, de520d4f-f987-47e5-9f70-ca74485ae8e8, ghrun-kipqlopw2q.auto.internal:28238): creating call state
2025-11-10 10:08:36,022 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, de520d4f-f987-47e5-9f70-ca74485ae8e8, ghrun-kipqlopw2q.auto.internal:28238): request = { session_id: "ydb://session/3?node_id=1&id=YjQzZGRlODUtNjA4YzA4NDEtOTM4ODdjMDItNWYyZWExMWI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select count(*) as Rows from `log_2_10000`" } stats_mode: STATS_MODE_NONE }
2025-11-10 10:08:36,027 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, de520d4f-f987-47e5-9f70-ca74485ae8e8, ghrun-kipqlopw2q.auto.internal:28238): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:08:36,356 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjQzZGRlODUtNjA4YzA4NDEtOTM4ODdjMDItNWYyZWExMWI=
2025-11-10 10:08:36,357 - INFO - root - test_overloads_workload: Count rows after insert 21280
2025-11-10 10:08:36,357 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjQzZGRlODUtNjA4YzA4NDEtOTM4ODdjMDItNWYyZWExMWI=
2025-11-10 10:08:36,358 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0179b28c-6f85-4033-b8cf-493f6a3991e6, ghrun-kipqlopw2q.auto.internal:28238): creating call state
2025-11-10 10:08:36,358 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0179b28c-6f85-4033-b8cf-493f6a3991e6, ghrun-kipqlopw2q.auto.internal:28238): request = { session_id: "ydb://session/3?node_id=1&id=YjQzZGRlODUtNjA4YzA4NDEtOTM4ODdjMDItNWYyZWExMWI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select count(*) as Rows from `log_2_10000`" } stats_mode: STATS_MODE_NONE }
2025-11-10 10:08:36,359 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0179b28c-6f85-4033-b8cf-493f6a3991e6, ghrun-kipqlopw2q.auto.internal:28238): response = { <_MultiThreadedRendezvous object> }
2025-11-10 10:08:36,480 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjQzZGRlODUtNjA4YzA4NDEtOTM4ODdjMDItNWYyZWExMWI=
2025-11-10 10:08:36,482 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.2
2025-11-10 10:08:36,482 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.10
2025-11-10 10:08:36,483 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/6t6o/0024d8/ydb/apps/ydb/ydb', '-e', 'grpc://localhost:28238', '-d', '/Root', 'workload', 'log', '--path', 'log_2_10000', 'clean']' in 'None' (waiting)
2025-11-10 10:08:36,496 - DEBUG - ya.test - execute: Command pid: 2244355
2025-11-10 10:08:36,797 - DEBUG - ya.test - _save_outputs: Command (pid 2244355) rc: 0
2025-11-10 10:08:36,797 - DEBUG - ya.test - _save_outputs: Command (pid 2244355) elapsed time (sec): 0.284376859664917
2025-11-10 10:08:36,808 - DEBUG - ya.test - _save_outputs: Command (pid 2244355) idrss: 0
2025-11-10 10:08:36,808 - DEBUG - ya.test - _save_outputs: Command (pid 2244355) inblock: 10656
2025-11-10 10:08:36,808 - DEBUG - ya.test - _save_outputs: Command (pid 2244355) isrss: 0
2025-11-10 10:08:36,808 - DEBUG - ya.test - _save_outputs: Command (pid 2244355) ixrss: 0
2025-11-10 10:08:36,808 - DEBUG - ya.test - _save_outputs: Command (pid 2244355) majflt: 2
2025-11-10 10:08:36,810 - DEBUG - ya.test - _save_outputs: Command (pid 2244355) maxrss: 174336
2025-11-10 10:08:36,811 - DEBUG - ya.test - _save_outputs: Command (pid 2244355) minflt: 3538
2025-11-10 10:08:36,812 - DEBUG - ya.test - _save_outputs: Command (pid 2244355) msgrcv: 0
2025-11-10 10:08:36,824 - DEBUG - ya.test - _save_outputs: Command (pid 2244355) msgsnd: 0
2025-11-10 10:08:36,824 - DEBUG - ya.test - _save_outputs: Command (pid 2244355) nivcsw: 28
2025-11-10 10:08:36,824 - DEBUG - ya.test - _save_outputs: Command (pid 2244355) nsignals: 0
2025-11-10 10:08:36,825 - DEBUG - ya.test - _save_outputs: Command (pid 2244355) nswap: 0
2025-11-10 10:08:36,825 - DEBUG - ya.test - _save_outputs: Command (pid 2244355) nvcsw: 181
2025-11-10 10:08:36,826 - DEBUG - ya.test - _save_outputs: Command (pid 2244355) oublock: 8
2025-11-10 10:08:36,826 - DEBUG - ya.test - _save_outputs: Command (pid 2244355) stime: 0.028634
2025-11-10 10:08:36,826 - DEBUG - ya.test - _save_outputs: Command (pid 2244355) utime: 0.057273
2025-11-10 10:08:36,826 - DEBUG - ya.test - _save_outputs: Command (pid 2244355) wtime: 0.305
2025-11-10 10:08:36,837 - DEBUG - ya.test - _save_outputs: Command (pid 2244355) output:
Remove path log_2_10000...
Remove path log_2_10000...Ok

2025-11-10 10:08:36,837 - DEBUG - ya.test - _save_outputs: Command (pid 2244355) errors:

2025-11-10 10:08:36,845 - INFO - ya.test - pytest_runtest_teardown: Test teardown
