2025-10-16 17:13:18,847 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-16 17:13:18,847 - INFO - ya.test - pytest_runtest_setup: test_dstool_evict_vdisk_grpc
2025-10-16 17:13:18,847 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-16 17:13:18,848 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-16 17:13:19,014 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/b9t0/001e21/ydb/apps/ydbd/ydbd
2025-10-16 17:13:19,017 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/63512
2025-10-16 17:13:19,019 - INFO - ydb.tests.library.fixtures - ydb_cluster: setup ydb_cluster for __tests__.test_canonical_records
2025-10-16 17:13:19,019 - INFO - ydb.tests.library.fixtures - ydb_cluster: setup ydb_cluster as local
2025-10-16 17:13:19,020 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/b9t0/001e21/r3tmp/kikimr_cluster_j9548ulu
2025-10-16 17:13:19,063 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/b9t0/001e21/ydb/apps/ydbd/ydbd
2025-10-16 17:13:19,064 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/24728
2025-10-16 17:13:19,065 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/32454
2025-10-16 17:13:19,065 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/10870
2025-10-16 17:13:19,066 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/31230
2025-10-16 17:13:19,067 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/b9t0/001e21/ydb/tests/functional/audit/test-results/py3test/testing_out_stuff/test_canonical_records/chunk5/testing_out_stuff/test_canonical_records.py.test_dstool_evict_vdisk_grpc/cluster/kikimr_configs"
2025-10-16 17:13:19,068 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/b9t0/001e21/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/b9t0/001e21/ydb/tests/functional/audit/test-results/py3test/testing_out_stuff/test_canonical_records/chunk5/testing_out_stuff/test_canonical_records.py.test_dstool_evict_vdisk_grpc/cluster/node_1/logfile_tpdu3v9x.log --grpc-port=24728 --mon-port=32454 --ic-port=63512
2025-10-16 17:13:19,069 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:24728/1, disk_size 68719476736
2025-10-16 17:13:19,069 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:2:64 on node localhost:24728/1, disk_size 68719476736
2025-10-16 17:13:19,070 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/b9t0/001e21/ydb/tests/functional/audit/test-results/py3test/testing_out_stuff/test_canonical_records/chunk5/testing_out_stuff/test_canonical_records.py.test_dstool_evict_vdisk_grpc/cluster/kikimr_configs"
2025-10-16 17:13:19,070 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/b9t0/001e21/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/b9t0/001e21/ydb/tests/functional/audit/test-results/py3test/testing_out_stuff/test_canonical_records/chunk5/testing_out_stuff/test_canonical_records.py.test_dstool_evict_vdisk_grpc/cluster/node_1/logfile_tpdu3v9x.log --grpc-port=24728 --mon-port=32454 --ic-port=63512
2025-10-16 17:13:19,072 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/b9t0/001e21/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/b9t0/001e21/ydb/tests/functional/audit/test-results/py3test/testing_out_stuff/test_canonical_records/chunk5/testing_out_stuff/test_canonical_records.py.test_dstool_evict_vdisk_grpc/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/b9t0/001e21/ydb/tests/functional/audit/test-results/py3test/testing_out_stuff/test_canonical_records/chunk5/testing_out_stuff/test_canonical_records.py.test_dstool_evict_vdisk_grpc/cluster/node_1/logfile_tpdu3v9x.log', '--grpc-port=24728', '--mon-port=32454', '--ic-port=63512')' in '/home/runner/.ya/build/build_root/b9t0/001e21/ydb/tests/functional/audit/test-results/py3test/testing_out_stuff/test_canonical_records/chunk5/testing_out_stuff/test_canonical_records.py.test_dstool_evict_vdisk_grpc/cluster/node_1' (no wait)
2025-10-16 17:13:19,079 - DEBUG - ya.test - execute: Command pid: 931716
2025-10-16 17:13:19,080 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:24728/1
2025-10-16 17:13:19,082 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-10-16 17:13:19,082 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-10-16 17:13:19,082 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/b9t0/001e21/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-16 17:13:19,085 - DEBUG - ya.test - execute: Command pid: 931720
2025-10-16 17:13:20,149 - DEBUG - ya.test - _save_outputs: Command (pid 931720) rc: 0
2025-10-16 17:13:20,149 - DEBUG - ya.test - _save_outputs: Command (pid 931720) elapsed time (sec): 1.0622854232788086
2025-10-16 17:13:20,150 - DEBUG - ya.test - _save_outputs: Command (pid 931720) idrss: 0
2025-10-16 17:13:20,150 - DEBUG - ya.test - _save_outputs: Command (pid 931720) inblock: 0
2025-10-16 17:13:20,150 - DEBUG - ya.test - _save_outputs: Command (pid 931720) isrss: 0
2025-10-16 17:13:20,151 - DEBUG - ya.test - _save_outputs: Command (pid 931720) ixrss: 0
2025-10-16 17:13:20,151 - DEBUG - ya.test - _save_outputs: Command (pid 931720) majflt: 0
2025-10-16 17:13:20,151 - DEBUG - ya.test - _save_outputs: Command (pid 931720) maxrss: 480376
2025-10-16 17:13:20,157 - DEBUG - ya.test - _save_outputs: Command (pid 931720) minflt: 45105
2025-10-16 17:13:20,157 - DEBUG - ya.test - _save_outputs: Command (pid 931720) msgrcv: 0
2025-10-16 17:13:20,165 - DEBUG - ya.test - _save_outputs: Command (pid 931720) msgsnd: 0
2025-10-16 17:13:20,176 - DEBUG - ya.test - _save_outputs: Command (pid 931720) nivcsw: 154
2025-10-16 17:13:20,177 - DEBUG - ya.test - _save_outputs: Command (pid 931720) nsignals: 0
2025-10-16 17:13:20,177 - DEBUG - ya.test - _save_outputs: Command (pid 931720) nswap: 0
2025-10-16 17:13:20,177 - DEBUG - ya.test - _save_outputs: Command (pid 931720) nvcsw: 14
2025-10-16 17:13:20,178 - DEBUG - ya.test - _save_outputs: Command (pid 931720) oublock: 8
2025-10-16 17:13:20,182 - DEBUG - ya.test - _save_outputs: Command (pid 931720) stime: 0.193621
2025-10-16 17:13:20,183 - DEBUG - ya.test - _save_outputs: Command (pid 931720) utime: 0.533693
2025-10-16 17:13:20,183 - DEBUG - ya.test - _save_outputs: Command (pid 931720) wtime: 1.066
2025-10-16 17:13:20,183 - DEBUG - ya.test - _save_outputs: Command (pid 931720) output:
Git info:
    Commit: d615d0ffd6e2f23c896ca96121aca842413fb672
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge 2f4fc663ace566d7ea72dd9c85ebd0092851e7e4 into 6819ac59eb1f43dd80b94010061f13b3ff17d91a

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-2kszfvc6cm
    Host information: 
        Linux ghrun-2kszfvc6cm 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 -DNDEBUG -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 -fsanitize=address -Daddress_sanitizer_enabled -fno-omit-frame-pointer -fsanitize-blacklist=/home/runner/actions_runner/_work/ydb/ydb/build/sanitize-blacklist.txt -fno-sanitize-link-runtime -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -DNDEBUG -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-10-16 17:13:20,184 - DEBUG - ya.test - _save_outputs: Command (pid 931720) errors:

2025-10-16 17:13:20,185 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: d615d0ffd6e2f23c896ca96121aca842413fb672
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge 2f4fc663ace566d7ea72dd9c85ebd0092851e7e4 into 6819ac59eb1f43dd80b94010061f13b3ff17d91a
2025-10-16 17:13:25,560 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/b9t0/001e21/ydb/apps/ydbd/ydbd
2025-10-16 17:13:25,561 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/b9t0/001e21/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:24728', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineHostConfig {\n    HostConfigId: 1\n    Drive {\n      Path: "SectorMap:1:64"\n    }\n    Drive {\n      Path: "SectorMap:2:64"\n    }\n  }\n}\nCommand {\n  DefineBox {\n    BoxId: 1\n    Host {\n      Key {\n        Fqdn: "localhost"\n        IcPort: 63512\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-10-16 17:13:25,562 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-10-16 17:13:25,562 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-10-16 17:13:25,563 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/b9t0/001e21/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:24728', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineHostConfig {\n    HostConfigId: 1\n    Drive {\n      Path: "SectorMap:1:64"\n    }\n    Drive {\n      Path: "SectorMap:2:64"\n    }\n  }\n}\nCommand {\n  DefineBox {\n    BoxId: 1\n    Host {\n      Key {\n        Fqdn: "localhost"\n        IcPort: 63512\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-10-16 17:13:25,564 - DEBUG - ya.test - execute: Command pid: 934666
2025-10-16 17:13:26,573 - DEBUG - ya.test - _save_outputs: Command (pid 934666) rc: 0
2025-10-16 17:13:26,573 - DEBUG - ya.test - _save_outputs: Command (pid 934666) elapsed time (sec): 1.0076630115509033
2025-10-16 17:13:26,574 - DEBUG - ya.test - _save_outputs: Command (pid 934666) idrss: 0
2025-10-16 17:13:26,574 - DEBUG - ya.test - _save_outputs: Command (pid 934666) inblock: 0
2025-10-16 17:13:26,574 - DEBUG - ya.test - _save_outputs: Command (pid 934666) isrss: 0
2025-10-16 17:13:26,574 - DEBUG - ya.test - _save_outputs: Command (pid 934666) ixrss: 0
2025-10-16 17:13:26,575 - DEBUG - ya.test - _save_outputs: Command (pid 934666) majflt: 0
2025-10-16 17:13:26,575 - DEBUG - ya.test - _save_outputs: Command (pid 934666) maxrss: 586044
2025-10-16 17:13:26,575 - DEBUG - ya.test - _save_outputs: Command (pid 934666) minflt: 51385
2025-10-16 17:13:26,576 - DEBUG - ya.test - _save_outputs: Command (pid 934666) msgrcv: 0
2025-10-16 17:13:26,576 - DEBUG - ya.test - _save_outputs: Command (pid 934666) msgsnd: 0
2025-10-16 17:13:26,576 - DEBUG - ya.test - _save_outputs: Command (pid 934666) nivcsw: 192
2025-10-16 17:13:26,581 - DEBUG - ya.test - _save_outputs: Command (pid 934666) nsignals: 0
2025-10-16 17:13:26,581 - DEBUG - ya.test - _save_outputs: Command (pid 934666) nswap: 0
2025-10-16 17:13:26,581 - DEBUG - ya.test - _save_outputs: Command (pid 934666) nvcsw: 387
2025-10-16 17:13:26,582 - DEBUG - ya.test - _save_outputs: Command (pid 934666) oublock: 8
2025-10-16 17:13:26,582 - DEBUG - ya.test - _save_outputs: Command (pid 934666) stime: 0.24814
2025-10-16 17:13:26,582 - DEBUG - ya.test - _save_outputs: Command (pid 934666) utime: 0.579248
2025-10-16 17:13:26,582 - DEBUG - ya.test - _save_outputs: Command (pid 934666) wtime: 1.009
2025-10-16 17:13:26,583 - DEBUG - ya.test - _save_outputs: Command (pid 934666) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 4

2025-10-16 17:13:26,583 - DEBUG - ya.test - _save_outputs: Command (pid 934666) errors:

2025-10-16 17:13:26,593 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/b9t0/001e21/ydb/apps/ydbd/ydbd
2025-10-16 17:13:26,594 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/b9t0/001e21/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:24728', '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-10-16 17:13:26,595 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-10-16 17:13:26,596 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-10-16 17:13:26,596 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/b9t0/001e21/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:24728', '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-10-16 17:13:26,598 - DEBUG - ya.test - execute: Command pid: 935201
2025-10-16 17:13:27,710 - DEBUG - ya.test - _save_outputs: Command (pid 935201) rc: 0
2025-10-16 17:13:27,711 - DEBUG - ya.test - _save_outputs: Command (pid 935201) elapsed time (sec): 1.1112306118011475
2025-10-16 17:13:27,711 - DEBUG - ya.test - _save_outputs: Command (pid 935201) idrss: 0
2025-10-16 17:13:27,712 - DEBUG - ya.test - _save_outputs: Command (pid 935201) inblock: 0
2025-10-16 17:13:27,712 - DEBUG - ya.test - _save_outputs: Command (pid 935201) isrss: 0
2025-10-16 17:13:27,712 - DEBUG - ya.test - _save_outputs: Command (pid 935201) ixrss: 0
2025-10-16 17:13:27,712 - DEBUG - ya.test - _save_outputs: Command (pid 935201) majflt: 0
2025-10-16 17:13:27,713 - DEBUG - ya.test - _save_outputs: Command (pid 935201) maxrss: 586916
2025-10-16 17:13:27,713 - DEBUG - ya.test - _save_outputs: Command (pid 935201) minflt: 51417
2025-10-16 17:13:27,713 - DEBUG - ya.test - _save_outputs: Command (pid 935201) msgrcv: 0
2025-10-16 17:13:27,714 - DEBUG - ya.test - _save_outputs: Command (pid 935201) msgsnd: 0
2025-10-16 17:13:27,714 - DEBUG - ya.test - _save_outputs: Command (pid 935201) nivcsw: 197
2025-10-16 17:13:27,714 - DEBUG - ya.test - _save_outputs: Command (pid 935201) nsignals: 0
2025-10-16 17:13:27,714 - DEBUG - ya.test - _save_outputs: Command (pid 935201) nswap: 0
2025-10-16 17:13:27,715 - DEBUG - ya.test - _save_outputs: Command (pid 935201) nvcsw: 614
2025-10-16 17:13:27,715 - DEBUG - ya.test - _save_outputs: Command (pid 935201) oublock: 8
2025-10-16 17:13:27,715 - DEBUG - ya.test - _save_outputs: Command (pid 935201) stime: 0.254692
2025-10-16 17:13:27,715 - DEBUG - ya.test - _save_outputs: Command (pid 935201) utime: 0.618065
2025-10-16 17:13:27,716 - DEBUG - ya.test - _save_outputs: Command (pid 935201) wtime: 1.113
2025-10-16 17:13:27,716 - DEBUG - ya.test - _save_outputs: Command (pid 935201) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-10-16 17:13:27,717 - DEBUG - ya.test - _save_outputs: Command (pid 935201) errors:

2025-10-16 17:13:27,718 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-10-16 17:13:27,848 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-10-16 17:13:27,884 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_canonical_records.py, test_name: test_dstool_evict_vdisk_grpc)
2025-10-16 17:13:27,886 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/b9t0/001e21/ydb/apps/dstool/ydb-dstool
2025-10-16 17:13:27,887 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb-dstool.out
2025-10-16 17:13:27,887 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb-dstool.err
2025-10-16 17:13:27,889 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/b9t0/001e21/ydb/apps/dstool/ydb-dstool', '--endpoint', 'grpc://localhost:24728', 'vdisk', 'list', '--format', 'json']' in 'None' (waiting)
2025-10-16 17:13:27,892 - DEBUG - ya.test - execute: Command pid: 935696
2025-10-16 17:13:30,627 - DEBUG - ya.test - _save_outputs: Command (pid 935696) rc: 0
2025-10-16 17:13:30,628 - DEBUG - ya.test - _save_outputs: Command (pid 935696) elapsed time (sec): 2.733820676803589
2025-10-16 17:13:30,628 - DEBUG - ya.test - _save_outputs: Command (pid 935696) idrss: 0
2025-10-16 17:13:30,629 - DEBUG - ya.test - _save_outputs: Command (pid 935696) inblock: 0
2025-10-16 17:13:30,629 - DEBUG - ya.test - _save_outputs: Command (pid 935696) isrss: 0
2025-10-16 17:13:30,629 - DEBUG - ya.test - _save_outputs: Command (pid 935696) ixrss: 0
2025-10-16 17:13:30,630 - DEBUG - ya.test - _save_outputs: Command (pid 935696) majflt: 1
2025-10-16 17:13:30,630 - DEBUG - ya.test - _save_outputs: Command (pid 935696) maxrss: 598240
2025-10-16 17:13:30,630 - DEBUG - ya.test - _save_outputs: Command (pid 935696) minflt: 85624
2025-10-16 17:13:30,631 - DEBUG - ya.test - _save_outputs: Command (pid 935696) msgrcv: 0
2025-10-16 17:13:30,631 - DEBUG - ya.test - _save_outputs: Command (pid 935696) msgsnd: 0
2025-10-16 17:13:30,631 - DEBUG - ya.test - _save_outputs: Command (pid 935696) nivcsw: 345
2025-10-16 17:13:30,632 - DEBUG - ya.test - _save_outputs: Command (pid 935696) nsignals: 0
2025-10-16 17:13:30,633 - DEBUG - ya.test - _save_outputs: Command (pid 935696) nswap: 0
2025-10-16 17:13:30,633 - DEBUG - ya.test - _save_outputs: Command (pid 935696) nvcsw: 536
2025-10-16 17:13:30,633 - DEBUG - ya.test - _save_outputs: Command (pid 935696) oublock: 8
2025-10-16 17:13:30,634 - DEBUG - ya.test - _save_outputs: Command (pid 935696) stime: 0.385573
2025-10-16 17:13:30,634 - DEBUG - ya.test - _save_outputs: Command (pid 935696) utime: 2.010354
2025-10-16 17:13:30,634 - DEBUG - ya.test - _save_outputs: Command (pid 935696) wtime: 2.738
2025-10-16 17:13:30,635 - DEBUG - ya.test - _save_outputs: Command (pid 935696) output:
[
  {
    "VDiskId": "[82000000:1:0:0:0]",
    "GroupId": 2181038080,
    "NodeId:PDiskId": "[1:1000]",
    "VSlotId": 1000,
    "VSlotStatus": "READY",
    "IsDonor": false,
    "GroupSizeInUnits": 0,
    "ReadOnly": false
  },
  {
    "VDiskId": "[82000001:1:0:0:0]",
    "GroupId": 2181038081,
    "NodeId:PDiskId": "[1:1000]",
    "VSlotId": 1001,
    "VSlotStatus": "READY",
    "IsDonor": false,
    "GroupSizeInUnits": 0,
    "ReadOnly": false
  }
]
2025-10-16 17:13:30,635 - DEBUG - ya.test - _save_outputs: Command (pid 935696) errors:

2025-10-16 17:14:00,661 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/b9t0/001e21/ydb/apps/dstool/ydb-dstool
2025-10-16 17:14:00,662 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb-dstool.out.0
2025-10-16 17:14:00,663 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb-dstool.err.0
2025-10-16 17:14:00,663 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/b9t0/001e21/ydb/apps/dstool/ydb-dstool', '--endpoint', 'grpc://localhost:24728', 'vdisk', 'evict', '--vdisk-ids', '[82000000:1:0:0:0]', '--ignore-degraded-group-check', '--ignore-failure-model-group-check']' in 'None' (waiting)
2025-10-16 17:14:00,669 - DEBUG - ya.test - execute: Command pid: 953892
2025-10-16 17:14:03,325 - DEBUG - ya.test - _save_outputs: Command (pid 953892) rc: 1
2025-10-16 17:14:03,326 - DEBUG - ya.test - _save_outputs: Command (pid 953892) elapsed time (sec): 2.654973030090332
2025-10-16 17:14:03,326 - DEBUG - ya.test - _save_outputs: Command (pid 953892) idrss: 0
2025-10-16 17:14:03,326 - DEBUG - ya.test - _save_outputs: Command (pid 953892) inblock: 0
2025-10-16 17:14:03,326 - DEBUG - ya.test - _save_outputs: Command (pid 953892) isrss: 0
2025-10-16 17:14:03,327 - DEBUG - ya.test - _save_outputs: Command (pid 953892) ixrss: 0
2025-10-16 17:14:03,327 - DEBUG - ya.test - _save_outputs: Command (pid 953892) majflt: 0
2025-10-16 17:14:03,327 - DEBUG - ya.test - _save_outputs: Command (pid 953892) maxrss: 598840
2025-10-16 17:14:03,328 - DEBUG - ya.test - _save_outputs: Command (pid 953892) minflt: 86910
2025-10-16 17:14:03,328 - DEBUG - ya.test - _save_outputs: Command (pid 953892) msgrcv: 0
2025-10-16 17:14:03,328 - DEBUG - ya.test - _save_outputs: Command (pid 953892) msgsnd: 0
2025-10-16 17:14:03,328 - DEBUG - ya.test - _save_outputs: Command (pid 953892) nivcsw: 432
2025-10-16 17:14:03,329 - DEBUG - ya.test - _save_outputs: Command (pid 953892) nsignals: 0
2025-10-16 17:14:03,329 - DEBUG - ya.test - _save_outputs: Command (pid 953892) nswap: 0
2025-10-16 17:14:03,329 - DEBUG - ya.test - _save_outputs: Command (pid 953892) nvcsw: 1178
2025-10-16 17:14:03,330 - DEBUG - ya.test - _save_outputs: Command (pid 953892) oublock: 8
2025-10-16 17:14:03,330 - DEBUG - ya.test - _save_outputs: Command (pid 953892) stime: 0.36347199999999996
2025-10-16 17:14:03,330 - DEBUG - ya.test - _save_outputs: Command (pid 953892) utime: 1.921583
2025-10-16 17:14:03,331 - DEBUG - ya.test - _save_outputs: Command (pid 953892) wtime: 2.661
2025-10-16 17:14:03,331 - DEBUG - ya.test - _save_outputs: Command (pid 953892) output:

2025-10-16 17:14:03,331 - DEBUG - ya.test - _save_outputs: Command (pid 953892) errors:
error, add --verbose for more info

2025-10-16 17:14:03,332 - DEBUG - ya.test - verify_sanitize_errors: No sanitizer errors found
2025-10-16 17:14:34,661 - ERROR - ya.test - logreport: ydb/tests/functional/audit/test_canonical_records.py:348: in test_dstool_evict_vdisk_grpc
    execute_dstool_grpc(ydb_cluster, TOKEN, ['vdisk', 'evict', '--vdisk-ids', vdisk_id, '--ignore-degraded-group-check', '--ignore-failure-model-group-check'])
../../../../../../../../../environment/arcadia/ydb/tests/functional/audit/helpers.py:60: in execute_dstool_grpc
    assert False, f'Command\n{full_cmd}\n finished with exit code {proc_result.exit_code}, stderr:\n\n{proc_result.std_err.decode("utf-8")}\n\nstdout:\n{proc_result.std_out.decode("utf-8")}'
E   AssertionError: Command
E   ['/home/runner/.ya/build/build_root/b9t0/001e21/ydb/apps/dstool/ydb-dstool', '--endpoint', 'grpc://localhost:24728', 'vdisk', 'evict', '--vdisk-ids', '[82000000:1:0:0:0]', '--ignore-degraded-group-check', '--ignore-failure-model-group-check']
E    finished with exit code 1, stderr:
E   
E   error, add --verbose for more info
E   
E   
E   stdout:
2025-10-16 17:14:34,664 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-10-16 17:14:34,665 - INFO - ydb.tests.library.fixtures - ydb_cluster: destroy ydb_cluster for __tests__.test_canonical_records
2025-10-16 17:14:41,673 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:24728/1
2025-10-16 17:14:41,676 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/31230
2025-10-16 17:14:41,677 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/10870
2025-10-16 17:14:41,677 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/32454
2025-10-16 17:14:41,678 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/24728
2025-10-16 17:14:41,679 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/63512
