2025-11-11 15:39:37,873 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-11 15:39:37,873 - INFO - ya.test - pytest_runtest_setup: test_overloads_workload[1000-2]
2025-11-11 15:39:37,873 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-11 15:39:37,873 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-11 15:39:37,888 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_overloads.py::TestLogScenario, test_name: test_overloads_workload[1000-2])
2025-11-11 15:39:37,889 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.7
2025-11-11 15:39:37,890 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.7
2025-11-11 15:39:37,890 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/iofl/001f30/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-11 15:39:37,898 - DEBUG - ya.test - execute: Command pid: 908995
2025-11-11 15:39:39,099 - DEBUG - ya.test - _save_outputs: Command (pid 908995) rc: 0
2025-11-11 15:39:39,100 - DEBUG - ya.test - _save_outputs: Command (pid 908995) elapsed time (sec): 1.200678825378418
2025-11-11 15:39:39,104 - DEBUG - ya.test - _save_outputs: Command (pid 908995) idrss: 0
2025-11-11 15:39:39,104 - DEBUG - ya.test - _save_outputs: Command (pid 908995) inblock: 0
2025-11-11 15:39:39,104 - DEBUG - ya.test - _save_outputs: Command (pid 908995) isrss: 0
2025-11-11 15:39:39,104 - DEBUG - ya.test - _save_outputs: Command (pid 908995) ixrss: 0
2025-11-11 15:39:39,105 - DEBUG - ya.test - _save_outputs: Command (pid 908995) majflt: 0
2025-11-11 15:39:39,105 - DEBUG - ya.test - _save_outputs: Command (pid 908995) maxrss: 541136
2025-11-11 15:39:39,105 - DEBUG - ya.test - _save_outputs: Command (pid 908995) minflt: 16167
2025-11-11 15:39:39,105 - DEBUG - ya.test - _save_outputs: Command (pid 908995) msgrcv: 0
2025-11-11 15:39:39,105 - DEBUG - ya.test - _save_outputs: Command (pid 908995) msgsnd: 0
2025-11-11 15:39:39,105 - DEBUG - ya.test - _save_outputs: Command (pid 908995) nivcsw: 131
2025-11-11 15:39:39,105 - DEBUG - ya.test - _save_outputs: Command (pid 908995) nsignals: 0
2025-11-11 15:39:39,106 - DEBUG - ya.test - _save_outputs: Command (pid 908995) nswap: 0
2025-11-11 15:39:39,106 - DEBUG - ya.test - _save_outputs: Command (pid 908995) nvcsw: 13
2025-11-11 15:39:39,106 - DEBUG - ya.test - _save_outputs: Command (pid 908995) oublock: 8
2025-11-11 15:39:39,106 - DEBUG - ya.test - _save_outputs: Command (pid 908995) stime: 0.203148
2025-11-11 15:39:39,106 - DEBUG - ya.test - _save_outputs: Command (pid 908995) utime: 0.133959
2025-11-11 15:39:39,106 - DEBUG - ya.test - _save_outputs: Command (pid 908995) wtime: 1.209
2025-11-11 15:39:39,106 - DEBUG - ya.test - _save_outputs: Command (pid 908995) output:
Git info:
    Commit: b1fe97d9d8127d8f2b1d0c3f6dfd6bba81272e1b
    Branch: 
    Author: Nikolay Shestakov <n.shestakov@gmail.com>
    Summary: Merge 50d8af9ebc780945b43536873ee711ed2559af4b into c6a8dfb1a22b05b4afbbf1cd50c1ca5a0dcd4305

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-3ynj4chmly
    Host information: 
        Linux ghrun-3ynj4chmly 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/10226725676/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10226725676/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-11 15:39:39,107 - DEBUG - ya.test - _save_outputs: Command (pid 908995) errors:

2025-11-11 15:39:39,107 - INFO - __tests__.test_overloads - _setup_ydb: Git info:
    Commit: b1fe97d9d8127d8f2b1d0c3f6dfd6bba81272e1b
    Branch: 
    Author: Nikolay Shestakov <n.shestakov@gmail.com>
    Summary: Merge 50d8af9ebc780945b43536873ee711ed2559af4b into c6a8dfb1a22b05b4afbbf1cd50c1ca5a0dcd4305

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-3ynj4chmly
    Host information: 
        Linux ghrun-3ynj4chmly 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/10226725676/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10226725676/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-11 15:39:39,448 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/iofl/001f30/ydb/apps/ydbd/ydbd
2025-11-11 15:39:39,449 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/26720
2025-11-11 15:39:39,450 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/iofl/001f30/r3tmp/kikimr_cluster_j4bgbz0_
2025-11-11 15:39:39,625 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/iofl/001f30/ydb/apps/ydbd/ydbd
2025-11-11 15:39:39,626 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/3716
2025-11-11 15:39:39,626 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/21982
2025-11-11 15:39:39,642 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/30270
2025-11-11 15:39:39,643 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/26240
2025-11-11 15:39:39,643 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/iofl/001f30/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/test_overloads.py.TestLogScenario.test_overloads_workload.1000-2/cluster/kikimr_configs"
2025-11-11 15:39:39,644 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/iofl/001f30/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/iofl/001f30/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/test_overloads.py.TestLogScenario.test_overloads_workload.1000-2/cluster/node_1/logfile_7dizuuh1.log --grpc-port=3716 --mon-port=21982 --ic-port=26720
2025-11-11 15:39:39,644 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:3716/1, disk_size 68719476736
2025-11-11 15:39:39,644 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/iofl/001f30/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/test_overloads.py.TestLogScenario.test_overloads_workload.1000-2/cluster/kikimr_configs"
2025-11-11 15:39:39,645 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/iofl/001f30/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/iofl/001f30/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/test_overloads.py.TestLogScenario.test_overloads_workload.1000-2/cluster/node_1/logfile_7dizuuh1.log --grpc-port=3716 --mon-port=21982 --ic-port=26720
2025-11-11 15:39:39,646 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/iofl/001f30/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/iofl/001f30/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/test_overloads.py.TestLogScenario.test_overloads_workload.1000-2/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/iofl/001f30/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/test_overloads.py.TestLogScenario.test_overloads_workload.1000-2/cluster/node_1/logfile_7dizuuh1.log', '--grpc-port=3716', '--mon-port=21982', '--ic-port=26720')' in '/home/runner/.ya/build/build_root/iofl/001f30/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/test_overloads.py.TestLogScenario.test_overloads_workload.1000-2/cluster/node_1' (no wait)
2025-11-11 15:39:39,652 - DEBUG - ya.test - execute: Command pid: 909845
2025-11-11 15:39:39,652 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:3716/1
2025-11-11 15:39:39,653 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.8
2025-11-11 15:39:39,654 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.8
2025-11-11 15:39:39,654 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/iofl/001f30/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-11 15:39:39,666 - DEBUG - ya.test - execute: Command pid: 909846
2025-11-11 15:39:40,722 - DEBUG - ya.test - _save_outputs: Command (pid 909846) rc: 0
2025-11-11 15:39:40,722 - DEBUG - ya.test - _save_outputs: Command (pid 909846) elapsed time (sec): 1.0551469326019287
2025-11-11 15:39:40,723 - DEBUG - ya.test - _save_outputs: Command (pid 909846) idrss: 0
2025-11-11 15:39:40,723 - DEBUG - ya.test - _save_outputs: Command (pid 909846) inblock: 0
2025-11-11 15:39:40,723 - DEBUG - ya.test - _save_outputs: Command (pid 909846) isrss: 0
2025-11-11 15:39:40,723 - DEBUG - ya.test - _save_outputs: Command (pid 909846) ixrss: 0
2025-11-11 15:39:40,723 - DEBUG - ya.test - _save_outputs: Command (pid 909846) majflt: 0
2025-11-11 15:39:40,723 - DEBUG - ya.test - _save_outputs: Command (pid 909846) maxrss: 541136
2025-11-11 15:39:40,724 - DEBUG - ya.test - _save_outputs: Command (pid 909846) minflt: 16169
2025-11-11 15:39:40,724 - DEBUG - ya.test - _save_outputs: Command (pid 909846) msgrcv: 0
2025-11-11 15:39:40,724 - DEBUG - ya.test - _save_outputs: Command (pid 909846) msgsnd: 0
2025-11-11 15:39:40,724 - DEBUG - ya.test - _save_outputs: Command (pid 909846) nivcsw: 96
2025-11-11 15:39:40,724 - DEBUG - ya.test - _save_outputs: Command (pid 909846) nsignals: 0
2025-11-11 15:39:40,724 - DEBUG - ya.test - _save_outputs: Command (pid 909846) nswap: 0
2025-11-11 15:39:40,725 - DEBUG - ya.test - _save_outputs: Command (pid 909846) nvcsw: 14
2025-11-11 15:39:40,725 - DEBUG - ya.test - _save_outputs: Command (pid 909846) oublock: 8
2025-11-11 15:39:40,725 - DEBUG - ya.test - _save_outputs: Command (pid 909846) stime: 0.19635999999999998
2025-11-11 15:39:40,725 - DEBUG - ya.test - _save_outputs: Command (pid 909846) utime: 0.135358
2025-11-11 15:39:40,725 - DEBUG - ya.test - _save_outputs: Command (pid 909846) wtime: 1.067
2025-11-11 15:39:40,726 - DEBUG - ya.test - _save_outputs: Command (pid 909846) output:
Git info:
    Commit: b1fe97d9d8127d8f2b1d0c3f6dfd6bba81272e1b
    Branch: 
    Author: Nikolay Shestakov <n.shestakov@gmail.com>
    Summary: Merge 50d8af9ebc780945b43536873ee711ed2559af4b into c6a8dfb1a22b05b4afbbf1cd50c1ca5a0dcd4305

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-3ynj4chmly
    Host information: 
        Linux ghrun-3ynj4chmly 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/10226725676/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10226725676/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-11 15:39:40,726 - DEBUG - ya.test - _save_outputs: Command (pid 909846) errors:

2025-11-11 15:39:40,726 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: b1fe97d9d8127d8f2b1d0c3f6dfd6bba81272e1b
    Branch: 
    Author: Nikolay Shestakov <n.shestakov@gmail.com>
    Summary: Merge 50d8af9ebc780945b43536873ee711ed2559af4b into c6a8dfb1a22b05b4afbbf1cd50c1ca5a0dcd4305
2025-11-11 15:39:43,575 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/iofl/001f30/ydb/apps/ydbd/ydbd
2025-11-11 15:39:43,575 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/iofl/001f30/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:3716', '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: 26720\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-11 15:39:43,576 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.9
2025-11-11 15:39:43,577 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.9
2025-11-11 15:39:43,577 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/iofl/001f30/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:3716', '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: 26720\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-11 15:39:43,610 - DEBUG - ya.test - execute: Command pid: 912635
2025-11-11 15:39:44,430 - DEBUG - ya.test - _save_outputs: Command (pid 912635) rc: 0
2025-11-11 15:39:44,430 - DEBUG - ya.test - _save_outputs: Command (pid 912635) elapsed time (sec): 0.8182263374328613
2025-11-11 15:39:44,430 - DEBUG - ya.test - _save_outputs: Command (pid 912635) idrss: 0
2025-11-11 15:39:44,430 - DEBUG - ya.test - _save_outputs: Command (pid 912635) inblock: 0
2025-11-11 15:39:44,430 - DEBUG - ya.test - _save_outputs: Command (pid 912635) isrss: 0
2025-11-11 15:39:44,431 - DEBUG - ya.test - _save_outputs: Command (pid 912635) ixrss: 0
2025-11-11 15:39:44,431 - DEBUG - ya.test - _save_outputs: Command (pid 912635) majflt: 0
2025-11-11 15:39:44,431 - DEBUG - ya.test - _save_outputs: Command (pid 912635) maxrss: 549388
2025-11-11 15:39:44,431 - DEBUG - ya.test - _save_outputs: Command (pid 912635) minflt: 18310
2025-11-11 15:39:44,431 - DEBUG - ya.test - _save_outputs: Command (pid 912635) msgrcv: 0
2025-11-11 15:39:44,431 - DEBUG - ya.test - _save_outputs: Command (pid 912635) msgsnd: 0
2025-11-11 15:39:44,432 - DEBUG - ya.test - _save_outputs: Command (pid 912635) nivcsw: 139
2025-11-11 15:39:44,432 - DEBUG - ya.test - _save_outputs: Command (pid 912635) nsignals: 0
2025-11-11 15:39:44,432 - DEBUG - ya.test - _save_outputs: Command (pid 912635) nswap: 0
2025-11-11 15:39:44,432 - DEBUG - ya.test - _save_outputs: Command (pid 912635) nvcsw: 65
2025-11-11 15:39:44,432 - DEBUG - ya.test - _save_outputs: Command (pid 912635) oublock: 8
2025-11-11 15:39:44,432 - DEBUG - ya.test - _save_outputs: Command (pid 912635) stime: 0.245384
2025-11-11 15:39:44,433 - DEBUG - ya.test - _save_outputs: Command (pid 912635) utime: 0.13719699999999999
2025-11-11 15:39:44,433 - DEBUG - ya.test - _save_outputs: Command (pid 912635) wtime: 0.852
2025-11-11 15:39:44,433 - DEBUG - ya.test - _save_outputs: Command (pid 912635) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 4

2025-11-11 15:39:44,433 - DEBUG - ya.test - _save_outputs: Command (pid 912635) errors:

2025-11-11 15:39:44,434 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/iofl/001f30/ydb/apps/ydbd/ydbd
2025-11-11 15:39:44,434 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/iofl/001f30/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:3716', '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-11 15:39:44,443 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.10
2025-11-11 15:39:44,444 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.10
2025-11-11 15:39:44,444 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/iofl/001f30/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:3716', '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-11 15:39:44,448 - DEBUG - ya.test - execute: Command pid: 913108
2025-11-11 15:39:45,299 - DEBUG - ya.test - _save_outputs: Command (pid 913108) rc: 0
2025-11-11 15:39:45,299 - DEBUG - ya.test - _save_outputs: Command (pid 913108) elapsed time (sec): 0.850593090057373
2025-11-11 15:39:45,300 - DEBUG - ya.test - _save_outputs: Command (pid 913108) idrss: 0
2025-11-11 15:39:45,300 - DEBUG - ya.test - _save_outputs: Command (pid 913108) inblock: 0
2025-11-11 15:39:45,300 - DEBUG - ya.test - _save_outputs: Command (pid 913108) isrss: 0
2025-11-11 15:39:45,300 - DEBUG - ya.test - _save_outputs: Command (pid 913108) ixrss: 0
2025-11-11 15:39:45,300 - DEBUG - ya.test - _save_outputs: Command (pid 913108) majflt: 0
2025-11-11 15:39:45,301 - DEBUG - ya.test - _save_outputs: Command (pid 913108) maxrss: 549396
2025-11-11 15:39:45,301 - DEBUG - ya.test - _save_outputs: Command (pid 913108) minflt: 18313
2025-11-11 15:39:45,301 - DEBUG - ya.test - _save_outputs: Command (pid 913108) msgrcv: 0
2025-11-11 15:39:45,301 - DEBUG - ya.test - _save_outputs: Command (pid 913108) msgsnd: 0
2025-11-11 15:39:45,301 - DEBUG - ya.test - _save_outputs: Command (pid 913108) nivcsw: 165
2025-11-11 15:39:45,301 - DEBUG - ya.test - _save_outputs: Command (pid 913108) nsignals: 0
2025-11-11 15:39:45,301 - DEBUG - ya.test - _save_outputs: Command (pid 913108) nswap: 0
2025-11-11 15:39:45,302 - DEBUG - ya.test - _save_outputs: Command (pid 913108) nvcsw: 75
2025-11-11 15:39:45,302 - DEBUG - ya.test - _save_outputs: Command (pid 913108) oublock: 8
2025-11-11 15:39:45,302 - DEBUG - ya.test - _save_outputs: Command (pid 913108) stime: 0.240999
2025-11-11 15:39:45,302 - DEBUG - ya.test - _save_outputs: Command (pid 913108) utime: 0.126035
2025-11-11 15:39:45,302 - DEBUG - ya.test - _save_outputs: Command (pid 913108) wtime: 0.854
2025-11-11 15:39:45,302 - DEBUG - ya.test - _save_outputs: Command (pid 913108) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-11 15:39:45,303 - DEBUG - ya.test - _save_outputs: Command (pid 913108) errors:

2025-11-11 15:39:45,303 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-11 15:39:45,352 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-11 15:39:45,375 - 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-11 15:39:45,385 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 15:39:45,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-11 15:39:45,415 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-11 15:39:45,416 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 5124209a-80b2-4622-a647-6a0cc416d93e, localhost:3716): creating call state
2025-11-11 15:39:45,416 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 5124209a-80b2-4622-a647-6a0cc416d93e, localhost:3716): request = { database: "/Root" }
2025-11-11 15:39:45,422 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 5124209a-80b2-4622-a647-6a0cc416d93e, localhost:3716): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-3ynj4chmly.auto.internal" port: 3716 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-11 15:39:45,423 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-3ynj4chmly.auto.internal:3716, location 1, ssl: False>]>
2025-11-11 15:39:45,423 - 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-11 15:39:45,452 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:3716
2025-11-11 15:39:45,452 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/iofl/001f30/ydb/apps/ydb/ydb
2025-11-11 15:39:45,453 - INFO - root - _call: YdbWorkloadOverload execute /home/runner/.ya/build/build_root/iofl/001f30/ydb/apps/ydb/ydb -e grpc://localhost:3716 -d /Root workload log --path log_1000_2 init --path log_1000_2 --store column --ttl 1000 with wait = True
2025-11-11 15:39:45,454 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.5
2025-11-11 15:39:45,454 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/iofl/001f30/ydb/apps/ydb/ydb', '-e', 'grpc://localhost:3716', '-d', '/Root', 'workload', 'log', '--path', 'log_1000_2', 'init', '--path', 'log_1000_2', '--store', 'column', '--ttl', '1000']' in 'None' (waiting)
2025-11-11 15:39:45,458 - DEBUG - ya.test - execute: Command pid: 913844
2025-11-11 15:39:46,787 - DEBUG - ya.test - _save_outputs: Command (pid 913844) rc: 0
2025-11-11 15:39:46,787 - DEBUG - ya.test - _save_outputs: Command (pid 913844) elapsed time (sec): 1.3280365467071533
2025-11-11 15:39:46,788 - DEBUG - ya.test - _save_outputs: Command (pid 913844) idrss: 0
2025-11-11 15:39:46,788 - DEBUG - ya.test - _save_outputs: Command (pid 913844) inblock: 0
2025-11-11 15:39:46,788 - DEBUG - ya.test - _save_outputs: Command (pid 913844) isrss: 0
2025-11-11 15:39:46,788 - DEBUG - ya.test - _save_outputs: Command (pid 913844) ixrss: 0
2025-11-11 15:39:46,788 - DEBUG - ya.test - _save_outputs: Command (pid 913844) majflt: 0
2025-11-11 15:39:46,788 - DEBUG - ya.test - _save_outputs: Command (pid 913844) maxrss: 177728
2025-11-11 15:39:46,788 - DEBUG - ya.test - _save_outputs: Command (pid 913844) minflt: 3547
2025-11-11 15:39:46,789 - DEBUG - ya.test - _save_outputs: Command (pid 913844) msgrcv: 0
2025-11-11 15:39:46,789 - DEBUG - ya.test - _save_outputs: Command (pid 913844) msgsnd: 0
2025-11-11 15:39:46,789 - DEBUG - ya.test - _save_outputs: Command (pid 913844) nivcsw: 52
2025-11-11 15:39:46,789 - DEBUG - ya.test - _save_outputs: Command (pid 913844) nsignals: 0
2025-11-11 15:39:46,789 - DEBUG - ya.test - _save_outputs: Command (pid 913844) nswap: 0
2025-11-11 15:39:46,789 - DEBUG - ya.test - _save_outputs: Command (pid 913844) nvcsw: 129
2025-11-11 15:39:46,790 - DEBUG - ya.test - _save_outputs: Command (pid 913844) oublock: 8
2025-11-11 15:39:46,790 - DEBUG - ya.test - _save_outputs: Command (pid 913844) stime: 0.008413
2025-11-11 15:39:46,790 - DEBUG - ya.test - _save_outputs: Command (pid 913844) utime: 0.071515
2025-11-11 15:39:46,790 - DEBUG - ya.test - _save_outputs: Command (pid 913844) wtime: 1.332
2025-11-11 15:39:46,790 - DEBUG - ya.test - _save_outputs: Command (pid 913844) output:
None
2025-11-11 15:39:46,790 - DEBUG - ya.test - _save_outputs: Command (pid 913844) errors:

2025-11-11 15:39:46,790 - INFO - root - _insert_rows: YdbWorkloadOverload bulk_upsert
2025-11-11 15:39:46,791 - INFO - root - _call: YdbWorkloadOverload execute /home/runner/.ya/build/build_root/iofl/001f30/ydb/apps/ydb/ydb -e grpc://localhost:3716 -d /Root workload log --path log_1000_2 run bulk_upsert --seconds 60 --threads 10 --rows 10 --quiet with wait = True
2025-11-11 15:39:46,796 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.6
2025-11-11 15:39:46,810 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/iofl/001f30/ydb/apps/ydb/ydb', '-e', 'grpc://localhost:3716', '-d', '/Root', 'workload', 'log', '--path', 'log_1000_2', 'run', 'bulk_upsert', '--seconds', '60', '--threads', '10', '--rows', '10', '--quiet']' in 'None' (waiting)
2025-11-11 15:39:46,820 - DEBUG - ya.test - execute: Command pid: 914623
2025-11-11 15:39:51,991 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 15:39:51,992 - 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-11 15:39:52,024 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-11 15:39:52,024 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, cfe9807b-58b0-4e28-b530-66faf50a32ec, localhost:17560): creating call state
2025-11-11 15:39:52,025 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, cfe9807b-58b0-4e28-b530-66faf50a32ec, localhost:17560): request = { database: "/Root" }
2025-11-11 15:39:52,028 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, cfe9807b-58b0-4e28-b530-66faf50a32ec, localhost:17560): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-3ynj4chmly.auto.internal" port: 17560 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-11 15:39:52,028 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-3ynj4chmly.auto.internal:17560, location 1, ssl: False>]>
2025-11-11 15:39:52,028 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:17560
2025-11-11 15:40:28,687 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 15:40:28,688 - 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-11 15:40:28,708 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-11 15:40:28,709 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 65045823-9591-46f1-9144-727c1f82f8a0, localhost:28650): creating call state
2025-11-11 15:40:28,709 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 65045823-9591-46f1-9144-727c1f82f8a0, localhost:28650): request = { database: "/Root" }
2025-11-11 15:40:28,715 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 65045823-9591-46f1-9144-727c1f82f8a0, localhost:28650): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-3ynj4chmly.auto.internal" port: 28650 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-11 15:40:28,716 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-3ynj4chmly.auto.internal:28650, location 1, ssl: False>]>
2025-11-11 15:40:28,716 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:28650
2025-11-11 15:41:02,392 - DEBUG - ya.test - _wait: Process resource usage is not available as process finished before wait4 was called
2025-11-11 15:41:02,392 - DEBUG - ya.test - _save_outputs: Command (pid 914623) rc: 0
2025-11-11 15:41:02,392 - DEBUG - ya.test - _save_outputs: Command (pid 914623) elapsed time (sec): 75.57092356681824
2025-11-11 15:41:02,392 - DEBUG - ya.test - _save_outputs: Command (pid 914623) wtime: 75.581
2025-11-11 15:41:02,393 - DEBUG - ya.test - _save_outputs: Command (pid 914623) output:
None
2025-11-11 15:41:02,393 - DEBUG - ya.test - _save_outputs: Command (pid 914623) errors:

2025-11-11 15:41:02,393 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-11 15:41:02,394 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, d438a7c9-3222-4863-9d7a-8f3c3f5936df, ghrun-3ynj4chmly.auto.internal:3716): creating call state
2025-11-11 15:41:02,394 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, d438a7c9-3222-4863-9d7a-8f3c3f5936df, ghrun-3ynj4chmly.auto.internal:3716): request = {  }
2025-11-11 15:41:02,404 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, d438a7c9-3222-4863-9d7a-8f3c3f5936df, ghrun-3ynj4chmly.auto.internal:3716): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=MThiYTVmMGEtN2ZiOWU0ZmUtZDQzOTJlMDktZjA2Yzk2ZjI=" node_id: 1 }
2025-11-11 15:41:02,404 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, 7df01b45-5717-4e59-9d49-0262eb464195, ghrun-3ynj4chmly.auto.internal:3716): creating call state
2025-11-11 15:41:02,405 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, 7df01b45-5717-4e59-9d49-0262eb464195, ghrun-3ynj4chmly.auto.internal:3716): request = { session_id: "ydb://session/3?node_id=1&id=MThiYTVmMGEtN2ZiOWU0ZmUtZDQzOTJlMDktZjA2Yzk2ZjI=" }
2025-11-11 15:41:02,408 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, 7df01b45-5717-4e59-9d49-0262eb464195, ghrun-3ynj4chmly.auto.internal:3716): response = { <_MultiThreadedRendezvous object> }
2025-11-11 15:41:02,428 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=MThiYTVmMGEtN2ZiOWU0ZmUtZDQzOTJlMDktZjA2Yzk2ZjI=
2025-11-11 15:41:02,428 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 078e4d4e-8449-48e8-85d7-227f1a35ab2c, ghrun-3ynj4chmly.auto.internal:3716): creating call state
2025-11-11 15:41:02,429 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 078e4d4e-8449-48e8-85d7-227f1a35ab2c, ghrun-3ynj4chmly.auto.internal:3716): request = { session_id: "ydb://session/3?node_id=1&id=MThiYTVmMGEtN2ZiOWU0ZmUtZDQzOTJlMDktZjA2Yzk2ZjI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select count(*) as Rows from `log_1000_2`" } stats_mode: STATS_MODE_NONE }
2025-11-11 15:41:02,429 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 078e4d4e-8449-48e8-85d7-227f1a35ab2c, ghrun-3ynj4chmly.auto.internal:3716): response = { <_MultiThreadedRendezvous object> }
2025-11-11 15:41:02,911 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MThiYTVmMGEtN2ZiOWU0ZmUtZDQzOTJlMDktZjA2Yzk2ZjI=
2025-11-11 15:41:02,912 - INFO - root - test_overloads_workload: Count rows after insert 4970
2025-11-11 15:41:02,912 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MThiYTVmMGEtN2ZiOWU0ZmUtZDQzOTJlMDktZjA2Yzk2ZjI=
2025-11-11 15:41:02,912 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, bfa4ec41-b7f9-4531-a593-7daa8018323f, ghrun-3ynj4chmly.auto.internal:3716): creating call state
2025-11-11 15:41:02,913 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, bfa4ec41-b7f9-4531-a593-7daa8018323f, ghrun-3ynj4chmly.auto.internal:3716): request = { session_id: "ydb://session/3?node_id=1&id=MThiYTVmMGEtN2ZiOWU0ZmUtZDQzOTJlMDktZjA2Yzk2ZjI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select count(*) as Rows from `log_1000_2`" } stats_mode: STATS_MODE_NONE }
2025-11-11 15:41:02,913 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, bfa4ec41-b7f9-4531-a593-7daa8018323f, ghrun-3ynj4chmly.auto.internal:3716): response = { <_MultiThreadedRendezvous object> }
2025-11-11 15:41:03,202 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MThiYTVmMGEtN2ZiOWU0ZmUtZDQzOTJlMDktZjA2Yzk2ZjI=
2025-11-11 15:41:03,203 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.1
2025-11-11 15:41:03,204 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.7
2025-11-11 15:41:03,204 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/iofl/001f30/ydb/apps/ydb/ydb', '-e', 'grpc://localhost:3716', '-d', '/Root', 'workload', 'log', '--path', 'log_1000_2', 'clean']' in 'None' (waiting)
2025-11-11 15:41:03,226 - DEBUG - ya.test - execute: Command pid: 954838
2025-11-11 15:41:03,621 - DEBUG - ya.test - _save_outputs: Command (pid 954838) rc: 0
2025-11-11 15:41:03,622 - DEBUG - ya.test - _save_outputs: Command (pid 954838) elapsed time (sec): 0.3950026035308838
2025-11-11 15:41:03,622 - DEBUG - ya.test - _save_outputs: Command (pid 954838) idrss: 0
2025-11-11 15:41:03,622 - DEBUG - ya.test - _save_outputs: Command (pid 954838) inblock: 0
2025-11-11 15:41:03,622 - DEBUG - ya.test - _save_outputs: Command (pid 954838) isrss: 0
2025-11-11 15:41:03,623 - DEBUG - ya.test - _save_outputs: Command (pid 954838) ixrss: 0
2025-11-11 15:41:03,623 - DEBUG - ya.test - _save_outputs: Command (pid 954838) majflt: 0
2025-11-11 15:41:03,623 - DEBUG - ya.test - _save_outputs: Command (pid 954838) maxrss: 177728
2025-11-11 15:41:03,623 - DEBUG - ya.test - _save_outputs: Command (pid 954838) minflt: 3538
2025-11-11 15:41:03,623 - DEBUG - ya.test - _save_outputs: Command (pid 954838) msgrcv: 0
2025-11-11 15:41:03,623 - DEBUG - ya.test - _save_outputs: Command (pid 954838) msgsnd: 0
2025-11-11 15:41:03,623 - DEBUG - ya.test - _save_outputs: Command (pid 954838) nivcsw: 43
2025-11-11 15:41:03,624 - DEBUG - ya.test - _save_outputs: Command (pid 954838) nsignals: 0
2025-11-11 15:41:03,624 - DEBUG - ya.test - _save_outputs: Command (pid 954838) nswap: 0
2025-11-11 15:41:03,624 - DEBUG - ya.test - _save_outputs: Command (pid 954838) nvcsw: 115
2025-11-11 15:41:03,624 - DEBUG - ya.test - _save_outputs: Command (pid 954838) oublock: 8
2025-11-11 15:41:03,624 - DEBUG - ya.test - _save_outputs: Command (pid 954838) stime: 0.034706
2025-11-11 15:41:03,624 - DEBUG - ya.test - _save_outputs: Command (pid 954838) utime: 0.047721
2025-11-11 15:41:03,625 - DEBUG - ya.test - _save_outputs: Command (pid 954838) wtime: 0.417
2025-11-11 15:41:03,625 - DEBUG - ya.test - _save_outputs: Command (pid 954838) output:
Remove path log_1000_2...
Remove path log_1000_2...Ok

2025-11-11 15:41:03,625 - DEBUG - ya.test - _save_outputs: Command (pid 954838) errors:

2025-11-11 15:41:03,628 - INFO - ya.test - pytest_runtest_teardown: Test teardown
