2026-01-08 02:56:08,747 - INFO - ya.test.2374848  - pytest_runtest_setup: ####################################################################################################
2026-01-08 02:56:08,747 - INFO - ya.test.2374848  - pytest_runtest_setup: test_multiple_files[tsv-additional_args3-row]
2026-01-08 02:56:08,747 - INFO - ya.test.2374848  - pytest_runtest_setup: ####################################################################################################
2026-01-08 02:56:08,747 - INFO - ya.test.2374848  - pytest_runtest_setup: Test setup
2026-01-08 02:56:08,787 - DEBUG - ya.test.2374848  - get_binary: Binary was found by /home/runner/.ya/build/build_root/pp6n/00343e/ydb/apps/ydbd/ydbd
2026-01-08 02:56:08,788 - DEBUG - library.python.filelock.2374848  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/14036
2026-01-08 02:56:08,788 - DEBUG - ydb.tests.library.harness.kikimr_runner.2374848  - start: Working directory: /home/runner/.ya/build/build_root/pp6n/00343e/r3tmp/kikimr_cluster_skdr56zc
2026-01-08 02:56:08,808 - DEBUG - ya.test.2374848  - get_binary: Binary was found by /home/runner/.ya/build/build_root/pp6n/00343e/ydb/apps/ydbd/ydbd
2026-01-08 02:56:08,809 - DEBUG - library.python.filelock.2374848  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/5880
2026-01-08 02:56:08,809 - DEBUG - library.python.filelock.2374848  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/17936
2026-01-08 02:56:08,809 - DEBUG - library.python.filelock.2374848  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/22896
2026-01-08 02:56:08,810 - DEBUG - library.python.filelock.2374848  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/8162
2026-01-08 02:56:08,810 - INFO - ydb.tests.library.harness.kikimr_runner.2374848  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/pp6n/00343e/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk17/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files.tsv-additional_args3-row/cluster/kikimr_configs"
2026-01-08 02:56:08,810 - INFO - ydb.tests.library.harness.kikimr_runner.2374848  - __make_run_command: Final command: /home/runner/.ya/build/build_root/pp6n/00343e/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/pp6n/00343e/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk17/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files.tsv-additional_args3-row/cluster/node_1/logfile_aijsaj8c.log --grpc-port=5880 --mon-port=17936 --ic-port=14036
2026-01-08 02:56:08,810 - DEBUG - ydb.tests.library.harness.kikimr_runner.2374848  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:5880/1, disk_size 68719476736
2026-01-08 02:56:08,811 - INFO - ydb.tests.library.harness.kikimr_runner.2374848  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/pp6n/00343e/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk17/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files.tsv-additional_args3-row/cluster/kikimr_configs"
2026-01-08 02:56:08,811 - INFO - ydb.tests.library.harness.kikimr_runner.2374848  - __make_run_command: Final command: /home/runner/.ya/build/build_root/pp6n/00343e/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/pp6n/00343e/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk17/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files.tsv-additional_args3-row/cluster/node_1/logfile_aijsaj8c.log --grpc-port=5880 --mon-port=17936 --ic-port=14036
2026-01-08 02:56:08,811 - DEBUG - ya.test.2374848  - execute: Executing '('/home/runner/.ya/build/build_root/pp6n/00343e/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/pp6n/00343e/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk17/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files.tsv-additional_args3-row/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/pp6n/00343e/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk17/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files.tsv-additional_args3-row/cluster/node_1/logfile_aijsaj8c.log', '--grpc-port=5880', '--mon-port=17936', '--ic-port=14036')' in '/home/runner/.ya/build/build_root/pp6n/00343e/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk17/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files.tsv-additional_args3-row/cluster/node_1' (no wait)
2026-01-08 02:56:08,812 - DEBUG - ya.test.2374848  - execute: Command pid: 2376654
2026-01-08 02:56:08,813 - INFO - ydb.tests.library.harness.kikimr_runner.2374848  - start: Started node localhost:5880/1
2026-01-08 02:56:08,813 - DEBUG - ya.test.2374848  - _get_command_output_file: Command out will be placed to ydbd.out
2026-01-08 02:56:08,814 - DEBUG - ya.test.2374848  - _get_command_output_file: Command err will be placed to ydbd.err
2026-01-08 02:56:08,814 - DEBUG - ya.test.2374848  - execute: Executing '['/home/runner/.ya/build/build_root/pp6n/00343e/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2026-01-08 02:56:08,814 - DEBUG - ya.test.2374848  - execute: Command pid: 2376655
2026-01-08 02:56:09,238 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2376655) rc: 0
2026-01-08 02:56:09,238 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2376655) elapsed time (sec): 0.4230649471282959
2026-01-08 02:56:09,239 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2376655) idrss: 0
2026-01-08 02:56:09,239 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2376655) inblock: 0
2026-01-08 02:56:09,239 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2376655) isrss: 0
2026-01-08 02:56:09,239 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2376655) ixrss: 0
2026-01-08 02:56:09,239 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2376655) majflt: 0
2026-01-08 02:56:09,240 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2376655) maxrss: 556296
2026-01-08 02:56:09,240 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2376655) minflt: 19731
2026-01-08 02:56:09,240 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2376655) msgrcv: 0
2026-01-08 02:56:09,240 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2376655) msgsnd: 0
2026-01-08 02:56:09,240 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2376655) nivcsw: 2
2026-01-08 02:56:09,240 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2376655) nsignals: 0
2026-01-08 02:56:09,241 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2376655) nswap: 0
2026-01-08 02:56:09,241 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2376655) nvcsw: 24
2026-01-08 02:56:09,241 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2376655) oublock: 8
2026-01-08 02:56:09,241 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2376655) stime: 0.273044
2026-01-08 02:56:09,241 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2376655) utime: 0.101685
2026-01-08 02:56:09,242 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2376655) wtime: 0.424
2026-01-08 02:56:09,242 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2376655) output:
Git info:
    Commit: 2498974ca152b7a4dd22679e7971857d09904db4
    Branch: 
    Author: Hor911 <hor911@ydb.tech>
    Summary: Merge 7aca38f946c83b69d6e02768574adc4e08ea0f50 into 05744b79f6132ebbd8de22eb67c4ad9b1d5acbde
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-paw7opzmb4    Host information: 
        Linux ghrun-paw7opzmb4 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/10492077879/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10492077879/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++

2026-01-08 02:56:09,242 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2376655) errors:

2026-01-08 02:56:09,242 - INFO - ydb.tests.library.harness.kikimr_runner.2374848  - start: Node 1 version:
Git info:
    Commit: 2498974ca152b7a4dd22679e7971857d09904db4
    Branch: 
    Author: Hor911 <hor911@ydb.tech>
    Summary: Merge 7aca38f946c83b69d6e02768574adc4e08ea0f50 into 05744b79f6132ebbd8de22eb67c4ad9b1d5acbde
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-paw7opzmb4    Host information: 
        Linux ghrun-paw7opzmb4 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64
2026-01-08 02:56:10,979 - DEBUG - ya.test.2374848  - get_binary: Binary was found by /home/runner/.ya/build/build_root/pp6n/00343e/ydb/apps/ydbd/ydbd
2026-01-08 02:56:10,979 - DEBUG - ydb.tests.library.harness.kikimr_runner.2374848  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/pp6n/00343e/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:5880', '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: 14036\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2026-01-08 02:56:10,980 - DEBUG - ya.test.2374848  - _get_command_output_file: Command out will be placed to ydbd.out.0
2026-01-08 02:56:10,981 - DEBUG - ya.test.2374848  - _get_command_output_file: Command err will be placed to ydbd.err.0
2026-01-08 02:56:10,981 - DEBUG - ya.test.2374848  - execute: Executing '['/home/runner/.ya/build/build_root/pp6n/00343e/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:5880', '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: 14036\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2026-01-08 02:56:10,982 - DEBUG - ya.test.2374848  - execute: Command pid: 2379601
2026-01-08 02:56:11,319 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2379601) rc: 0
2026-01-08 02:56:11,319 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2379601) elapsed time (sec): 0.3361680507659912
2026-01-08 02:56:11,319 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2379601) idrss: 0
2026-01-08 02:56:11,319 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2379601) inblock: 0
2026-01-08 02:56:11,320 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2379601) isrss: 0
2026-01-08 02:56:11,320 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2379601) ixrss: 0
2026-01-08 02:56:11,320 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2379601) majflt: 0
2026-01-08 02:56:11,320 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2379601) maxrss: 564740
2026-01-08 02:56:11,320 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2379601) minflt: 18557
2026-01-08 02:56:11,320 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2379601) msgrcv: 0
2026-01-08 02:56:11,320 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2379601) msgsnd: 0
2026-01-08 02:56:11,320 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2379601) nivcsw: 2
2026-01-08 02:56:11,320 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2379601) nsignals: 0
2026-01-08 02:56:11,321 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2379601) nswap: 0
2026-01-08 02:56:11,321 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2379601) nvcsw: 127
2026-01-08 02:56:11,321 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2379601) oublock: 8
2026-01-08 02:56:11,321 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2379601) stime: 0.176486
2026-01-08 02:56:11,321 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2379601) utime: 0.11595899999999999
2026-01-08 02:56:11,321 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2379601) wtime: 0.337
2026-01-08 02:56:11,321 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2379601) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 4

2026-01-08 02:56:11,322 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2379601) errors:

2026-01-08 02:56:11,322 - DEBUG - ya.test.2374848  - get_binary: Binary was found by /home/runner/.ya/build/build_root/pp6n/00343e/ydb/apps/ydbd/ydbd
2026-01-08 02:56:11,323 - DEBUG - ydb.tests.library.harness.kikimr_runner.2374848  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/pp6n/00343e/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:5880', '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']
2026-01-08 02:56:11,323 - DEBUG - ya.test.2374848  - _get_command_output_file: Command out will be placed to ydbd.out.1
2026-01-08 02:56:11,324 - DEBUG - ya.test.2374848  - _get_command_output_file: Command err will be placed to ydbd.err.1
2026-01-08 02:56:11,324 - DEBUG - ya.test.2374848  - execute: Executing '['/home/runner/.ya/build/build_root/pp6n/00343e/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:5880', '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)
2026-01-08 02:56:11,324 - DEBUG - ya.test.2374848  - execute: Command pid: 2380158
2026-01-08 02:56:11,662 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380158) rc: 0
2026-01-08 02:56:11,662 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380158) elapsed time (sec): 0.33669567108154297
2026-01-08 02:56:11,662 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380158) idrss: 0
2026-01-08 02:56:11,662 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380158) inblock: 0
2026-01-08 02:56:11,662 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380158) isrss: 0
2026-01-08 02:56:11,663 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380158) ixrss: 0
2026-01-08 02:56:11,663 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380158) majflt: 0
2026-01-08 02:56:11,663 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380158) maxrss: 564724
2026-01-08 02:56:11,663 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380158) minflt: 18560
2026-01-08 02:56:11,663 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380158) msgrcv: 0
2026-01-08 02:56:11,663 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380158) msgsnd: 0
2026-01-08 02:56:11,663 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380158) nivcsw: 2
2026-01-08 02:56:11,663 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380158) nsignals: 0
2026-01-08 02:56:11,663 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380158) nswap: 0
2026-01-08 02:56:11,663 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380158) nvcsw: 136
2026-01-08 02:56:11,663 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380158) oublock: 8
2026-01-08 02:56:11,664 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380158) stime: 0.19203499999999998
2026-01-08 02:56:11,664 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380158) utime: 0.100018
2026-01-08 02:56:11,664 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380158) wtime: 0.337
2026-01-08 02:56:11,664 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380158) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2026-01-08 02:56:11,664 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380158) errors:

2026-01-08 02:56:11,664 - INFO - ydb.tests.library.harness.kikimr_runner.2374848  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2026-01-08 02:56:11,675 - INFO - ydb.tests.library.harness.kikimr_runner.2374848  - __run: Cluster started and initialized
2026-01-08 02:56:11,683 - DEBUG - ydb.connection.2374848  - 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', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2026-01-08 02:56:11,684 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2374848  - context_resolve: Preparing initial endpoint to resolve endpoints
2026-01-08 02:56:11,686 - DEBUG - ydb.connection.2374848  - 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', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2026-01-08 02:56:11,692 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2374848  - context_resolve: Resolving endpoints for database /Root
2026-01-08 02:56:11,693 - DEBUG - ydb.connection.2374848  - _prepare_call: RpcState(ListEndpoints, f10e5f83-999b-4d68-8a9c-8b69414776d1, localhost:5880): creating call state
2026-01-08 02:56:11,693 - DEBUG - ydb.connection.2374848  - _log_request: RpcState(ListEndpoints, f10e5f83-999b-4d68-8a9c-8b69414776d1, localhost:5880): request = { database: "/Root" }
2026-01-08 02:56:11,696 - DEBUG - ydb.connection.2374848  - _log_response: RpcState(ListEndpoints, f10e5f83-999b-4d68-8a9c-8b69414776d1, localhost:5880): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-paw7opzmb4.auto.internal" port: 5880 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" } } } }
2026-01-08 02:56:11,697 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2374848  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-paw7opzmb4.auto.internal:5880, location 1, ssl: False>]>
2026-01-08 02:56:11,697 - DEBUG - ydb.connection.2374848  - 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', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2026-01-08 02:56:11,704 - DEBUG - ydb.connection.2374848  - close: Closing channel for endpoint localhost:5880
2026-01-08 02:56:11,704 - DEBUG - ydb.connection.2374848  - _prepare_call: RpcState(CreateSession, 214c8f0a-c41b-448c-ae30-6b64cdf24c53, ghrun-paw7opzmb4.auto.internal:5880): creating call state
2026-01-08 02:56:11,705 - DEBUG - ydb.connection.2374848  - _log_request: RpcState(CreateSession, 214c8f0a-c41b-448c-ae30-6b64cdf24c53, ghrun-paw7opzmb4.auto.internal:5880): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2026-01-08 02:56:11,707 - DEBUG - ydb.connection.2374848  - _log_response: RpcState(CreateSession, 214c8f0a-c41b-448c-ae30-6b64cdf24c53, ghrun-paw7opzmb4.auto.internal:5880): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=OWNjY2NjMzAtYTY1MGM1NDMtMzk3OGM0OWUtOTQ4NDIxNTA=" } } } }
2026-01-08 02:56:11,709 - INFO - ya.test.2374848  - pytest_runtest_call: Test call (class_name: test_ydb_impex.py::TestImpex, test_name: test_multiple_files[tsv-additional_args3-row])
2026-01-08 02:56:11,710 - DEBUG - ydb.connection.2374848  - _prepare_call: RpcState(ExecuteSchemeQuery, b9167f17-9bcc-4a63-a0e5-82076935d538, ghrun-paw7opzmb4.auto.internal:5880): creating call state
2026-01-08 02:56:11,710 - DEBUG - ydb.connection.2374848  - _log_request: RpcState(ExecuteSchemeQuery, b9167f17-9bcc-4a63-a0e5-82076935d538, ghrun-paw7opzmb4.auto.internal:5880): request = { session_id: "ydb://session/3?node_id=1&id=OWNjY2NjMzAtYTY1MGM1NDMtMzk3OGM0OWUtOTQ4NDIxNTA=" yql_text: "\n        CREATE TABLE `/Root/test_multiple_files[tsv-additional_args3-row]` (\n            key Uint32 NOT NULL,\n            id Uint64,\n            value Utf8,\n            PRIMARY KEY(key)\n        )\n        \n        WITH (\n            STORE = row\n        )\n        " operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2026-01-08 02:56:11,745 - DEBUG - ydb.connection.2374848  - _log_response: RpcState(ExecuteSchemeQuery, b9167f17-9bcc-4a63-a0e5-82076935d538, ghrun-paw7opzmb4.auto.internal:5880): response = { operation { ready: true status: SUCCESS } }
2026-01-08 02:56:11,746 - DEBUG - ya.test.2374848  - get_binary: Binary was found by /home/runner/.ya/build/build_root/pp6n/00343e/ydb/apps/ydb/ydb
2026-01-08 02:56:11,747 - DEBUG - ya.test.2374848  - _get_command_output_file: Command out will be placed to ydb.out
2026-01-08 02:56:11,747 - DEBUG - ya.test.2374848  - _get_command_output_file: Command err will be placed to ydb.err
2026-01-08 02:56:11,747 - DEBUG - ya.test.2374848  - execute: Executing '['/home/runner/.ya/build/build_root/pp6n/00343e/ydb/apps/ydb/ydb', '--endpoint', 'grpc://localhost:5880', '--database', '/Root', 'import', 'file', 'tsv', '-p', '/Root/test_multiple_files[tsv-additional_args3-row]', '--header', '--newline-delimited', '/home/runner/.ya/build/build_root/pp6n/00343e/tmp/test_multiple_files_tsv_additi0/tempinput0.tsv', '/home/runner/.ya/build/build_root/pp6n/00343e/tmp/test_multiple_files_tsv_additi0/tempinput1.tsv', '/home/runner/.ya/build/build_root/pp6n/00343e/tmp/test_multiple_files_tsv_additi0/tempinput2.tsv', '/home/runner/.ya/build/build_root/pp6n/00343e/tmp/test_multiple_files_tsv_additi0/tempinput3.tsv']' in 'None' (waiting)
2026-01-08 02:56:11,748 - DEBUG - ya.test.2374848  - execute: Command pid: 2380510
2026-01-08 02:56:11,877 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380510) rc: 0
2026-01-08 02:56:11,877 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380510) elapsed time (sec): 0.12819886207580566
2026-01-08 02:56:11,877 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380510) idrss: 0
2026-01-08 02:56:11,878 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380510) inblock: 0
2026-01-08 02:56:11,878 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380510) isrss: 0
2026-01-08 02:56:11,878 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380510) ixrss: 0
2026-01-08 02:56:11,878 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380510) majflt: 0
2026-01-08 02:56:11,878 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380510) maxrss: 183868
2026-01-08 02:56:11,878 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380510) minflt: 4531
2026-01-08 02:56:11,879 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380510) msgrcv: 0
2026-01-08 02:56:11,879 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380510) msgsnd: 0
2026-01-08 02:56:11,879 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380510) nivcsw: 2
2026-01-08 02:56:11,879 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380510) nsignals: 0
2026-01-08 02:56:11,879 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380510) nswap: 0
2026-01-08 02:56:11,879 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380510) nvcsw: 994
2026-01-08 02:56:11,880 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380510) oublock: 48
2026-01-08 02:56:11,880 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380510) stime: 0.046440999999999996
2026-01-08 02:56:11,880 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380510) utime: 0.046440999999999996
2026-01-08 02:56:11,880 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380510) wtime: 0.129
2026-01-08 02:56:11,880 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380510) output:

2026-01-08 02:56:11,880 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380510) errors:
Elapsed: 0.00618 sec. Total read size: 290B. Average processing speed: 45.8KiB/s.


2026-01-08 02:56:11,881 - DEBUG - __tests__.test_ydb_impex.2374848  - execute_ydb_cli_command: std_out:

2026-01-08 02:56:11,881 - DEBUG - ya.test.2374848  - get_binary: Binary was found by /home/runner/.ya/build/build_root/pp6n/00343e/ydb/apps/ydb/ydb
2026-01-08 02:56:11,882 - DEBUG - ya.test.2374848  - _get_command_output_file: Command err will be placed to ydb.err.0
2026-01-08 02:56:11,882 - DEBUG - ya.test.2374848  - execute: Executing '['/home/runner/.ya/build/build_root/pp6n/00343e/ydb/apps/ydb/ydb', '--endpoint', 'grpc://localhost:5880', '--database', '/Root', 'table', 'query', 'execute', '-q', 'SELECT `key`, `id`, `value` FROM `/Root/test_multiple_files[tsv-additional_args3-row]` ORDER BY `key`', '-t', 'scan', '--format', 'tsv']' in 'None' (waiting)
2026-01-08 02:56:11,883 - DEBUG - ya.test.2374848  - execute: Command pid: 2380786
2026-01-08 02:56:12,009 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380786) rc: 0
2026-01-08 02:56:12,009 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380786) elapsed time (sec): 0.12462496757507324
2026-01-08 02:56:12,009 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380786) idrss: 0
2026-01-08 02:56:12,009 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380786) inblock: 0
2026-01-08 02:56:12,009 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380786) isrss: 0
2026-01-08 02:56:12,009 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380786) ixrss: 0
2026-01-08 02:56:12,010 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380786) majflt: 3
2026-01-08 02:56:12,010 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380786) maxrss: 183868
2026-01-08 02:56:12,010 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380786) minflt: 3628
2026-01-08 02:56:12,010 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380786) msgrcv: 0
2026-01-08 02:56:12,010 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380786) msgsnd: 0
2026-01-08 02:56:12,010 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380786) nivcsw: 1
2026-01-08 02:56:12,010 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380786) nsignals: 0
2026-01-08 02:56:12,010 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380786) nswap: 0
2026-01-08 02:56:12,010 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380786) nvcsw: 205
2026-01-08 02:56:12,011 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380786) oublock: 8
2026-01-08 02:56:12,011 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380786) stime: 0.029592
2026-01-08 02:56:12,011 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380786) utime: 0.029592
2026-01-08 02:56:12,011 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380786) wtime: 0.126
2026-01-08 02:56:12,011 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380786) output:
1	1111	"one"
2	2222	"two"
3	3333	"three"
5	5555	"five"
7	7777	"seven"
11	1111	"one"
22	2222	"two"
33	3333	"three"
55	5555	"five"
77	7777	"seven"
111	1111	"one"
222	2222	"two"
333	3333	"three"
555	5555	"five"
777	7777	"seven"
1111	1111	"one"
2222	2222	"two"
3333	3333	"three"
5555	5555	"five"
7777	7777	"seven"

2026-01-08 02:56:12,011 - DEBUG - ya.test.2374848  - _save_outputs: Command (pid 2380786) errors:

2026-01-08 02:56:12,011 - DEBUG - __tests__.test_ydb_impex.2374848  - execute_ydb_cli_command: std_out:
1	1111	"one"
2	2222	"two"
3	3333	"three"
5	5555	"five"
7	7777	"seven"
11	1111	"one"
22	2222	"two"
33	3333	"three"
55	5555	"five"
77	7777	"seven"
111	1111	"one"
222	2222	"two"
333	3333	"three"
555	5555	"five"
777	7777	"seven"
1111	1111	"one"
2222	2222	"two"
3333	3333	"three"
5555	5555	"five"
7777	7777	"seven"

2026-01-08 02:56:12,013 - INFO - ya.test.2374848  - pytest_runtest_teardown: Test teardown
2026-01-08 02:56:35,315 - DEBUG - ya.test - _verify_test: Verifying [test_ydb_impex.TestImpex.test_multiple_files[tsv-additional_args3-row] in ydb/tests/functional/ydb_cli] canonical results
2026-01-08 02:56:35,318 - DEBUG - ya.test - verify: Test test_ydb_impex.TestImpex.test_multiple_files[tsv-additional_args3-row] status: good
