2026-01-08 02:56:07,324 - INFO - ya.test.2374524  - pytest_runtest_setup: ####################################################################################################
2026-01-08 02:56:07,324 - INFO - ya.test.2374524  - pytest_runtest_setup: test_multiple_files[tsv-additional_args2-column]
2026-01-08 02:56:07,324 - INFO - ya.test.2374524  - pytest_runtest_setup: ####################################################################################################
2026-01-08 02:56:07,324 - INFO - ya.test.2374524  - pytest_runtest_setup: Test setup
2026-01-08 02:56:07,373 - DEBUG - ya.test.2374524  - get_binary: Binary was found by /home/runner/.ya/build/build_root/pp6n/003444/ydb/apps/ydbd/ydbd
2026-01-08 02:56:07,373 - DEBUG - library.python.filelock.2374524  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/2767
2026-01-08 02:56:07,374 - DEBUG - ydb.tests.library.harness.kikimr_runner.2374524  - start: Working directory: /home/runner/.ya/build/build_root/pp6n/003444/r3tmp/kikimr_cluster__8ipqhpu
2026-01-08 02:56:07,411 - DEBUG - ya.test.2374524  - get_binary: Binary was found by /home/runner/.ya/build/build_root/pp6n/003444/ydb/apps/ydbd/ydbd
2026-01-08 02:56:07,412 - DEBUG - library.python.filelock.2374524  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/7259
2026-01-08 02:56:07,412 - DEBUG - library.python.filelock.2374524  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/5992
2026-01-08 02:56:07,413 - DEBUG - library.python.filelock.2374524  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/5684
2026-01-08 02:56:07,413 - DEBUG - library.python.filelock.2374524  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/5685
2026-01-08 02:56:07,413 - DEBUG - library.python.filelock.2374524  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/30282
2026-01-08 02:56:07,414 - INFO - ydb.tests.library.harness.kikimr_runner.2374524  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/pp6n/003444/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk16/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files.tsv-additional_args2-column/cluster/kikimr_configs"
2026-01-08 02:56:07,414 - INFO - ydb.tests.library.harness.kikimr_runner.2374524  - __make_run_command: Final command: /home/runner/.ya/build/build_root/pp6n/003444/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/003444/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk16/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files.tsv-additional_args2-column/cluster/node_1/logfile_3547ur93.log --grpc-port=7259 --mon-port=5992 --ic-port=2767
2026-01-08 02:56:07,415 - DEBUG - ydb.tests.library.harness.kikimr_runner.2374524  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:7259/1, disk_size 68719476736
2026-01-08 02:56:07,415 - INFO - ydb.tests.library.harness.kikimr_runner.2374524  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/pp6n/003444/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk16/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files.tsv-additional_args2-column/cluster/kikimr_configs"
2026-01-08 02:56:07,415 - INFO - ydb.tests.library.harness.kikimr_runner.2374524  - __make_run_command: Final command: /home/runner/.ya/build/build_root/pp6n/003444/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/003444/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk16/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files.tsv-additional_args2-column/cluster/node_1/logfile_3547ur93.log --grpc-port=7259 --mon-port=5992 --ic-port=2767
2026-01-08 02:56:07,416 - DEBUG - ya.test.2374524  - execute: Executing '('/home/runner/.ya/build/build_root/pp6n/003444/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/pp6n/003444/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk16/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files.tsv-additional_args2-column/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/pp6n/003444/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk16/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files.tsv-additional_args2-column/cluster/node_1/logfile_3547ur93.log', '--grpc-port=7259', '--mon-port=5992', '--ic-port=2767')' in '/home/runner/.ya/build/build_root/pp6n/003444/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk16/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files.tsv-additional_args2-column/cluster/node_1' (no wait)
2026-01-08 02:56:07,418 - DEBUG - ya.test.2374524  - execute: Command pid: 2374961
2026-01-08 02:56:07,419 - INFO - ydb.tests.library.harness.kikimr_runner.2374524  - start: Started node localhost:7259/1
2026-01-08 02:56:07,420 - DEBUG - ya.test.2374524  - _get_command_output_file: Command out will be placed to ydbd.out
2026-01-08 02:56:07,420 - DEBUG - ya.test.2374524  - _get_command_output_file: Command err will be placed to ydbd.err
2026-01-08 02:56:07,420 - DEBUG - ya.test.2374524  - execute: Executing '['/home/runner/.ya/build/build_root/pp6n/003444/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2026-01-08 02:56:07,421 - DEBUG - ya.test.2374524  - execute: Command pid: 2374962
2026-01-08 02:56:07,867 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2374962) rc: 0
2026-01-08 02:56:07,868 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2374962) elapsed time (sec): 0.44513630867004395
2026-01-08 02:56:07,868 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2374962) idrss: 0
2026-01-08 02:56:07,868 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2374962) inblock: 0
2026-01-08 02:56:07,868 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2374962) isrss: 0
2026-01-08 02:56:07,868 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2374962) ixrss: 0
2026-01-08 02:56:07,868 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2374962) majflt: 0
2026-01-08 02:56:07,869 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2374962) maxrss: 556284
2026-01-08 02:56:07,869 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2374962) minflt: 16415
2026-01-08 02:56:07,869 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2374962) msgrcv: 0
2026-01-08 02:56:07,869 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2374962) msgsnd: 0
2026-01-08 02:56:07,869 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2374962) nivcsw: 0
2026-01-08 02:56:07,869 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2374962) nsignals: 0
2026-01-08 02:56:07,869 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2374962) nswap: 0
2026-01-08 02:56:07,870 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2374962) nvcsw: 13
2026-01-08 02:56:07,870 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2374962) oublock: 8
2026-01-08 02:56:07,870 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2374962) stime: 0.31282099999999996
2026-01-08 02:56:07,870 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2374962) utime: 0.08422099999999999
2026-01-08 02:56:07,870 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2374962) wtime: 0.446
2026-01-08 02:56:07,870 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2374962) 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:07,871 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2374962) errors:

2026-01-08 02:56:07,871 - INFO - ydb.tests.library.harness.kikimr_runner.2374524  - 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:09,629 - DEBUG - ya.test.2374524  - get_binary: Binary was found by /home/runner/.ya/build/build_root/pp6n/003444/ydb/apps/ydbd/ydbd
2026-01-08 02:56:09,629 - DEBUG - ydb.tests.library.harness.kikimr_runner.2374524  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/pp6n/003444/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:7259', '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: 2767\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2026-01-08 02:56:09,630 - DEBUG - ya.test.2374524  - _get_command_output_file: Command out will be placed to ydbd.out.0
2026-01-08 02:56:09,630 - DEBUG - ya.test.2374524  - _get_command_output_file: Command err will be placed to ydbd.err.0
2026-01-08 02:56:09,630 - DEBUG - ya.test.2374524  - execute: Executing '['/home/runner/.ya/build/build_root/pp6n/003444/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:7259', '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: 2767\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2026-01-08 02:56:09,631 - DEBUG - ya.test.2374524  - execute: Command pid: 2377406
2026-01-08 02:56:10,172 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2377406) rc: 0
2026-01-08 02:56:10,173 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2377406) elapsed time (sec): 0.5404834747314453
2026-01-08 02:56:10,173 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2377406) idrss: 0
2026-01-08 02:56:10,173 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2377406) inblock: 0
2026-01-08 02:56:10,173 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2377406) isrss: 0
2026-01-08 02:56:10,173 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2377406) ixrss: 0
2026-01-08 02:56:10,174 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2377406) majflt: 0
2026-01-08 02:56:10,174 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2377406) maxrss: 564736
2026-01-08 02:56:10,174 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2377406) minflt: 18557
2026-01-08 02:56:10,174 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2377406) msgrcv: 0
2026-01-08 02:56:10,174 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2377406) msgsnd: 0
2026-01-08 02:56:10,174 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2377406) nivcsw: 1
2026-01-08 02:56:10,175 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2377406) nsignals: 0
2026-01-08 02:56:10,175 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2377406) nswap: 0
2026-01-08 02:56:10,175 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2377406) nvcsw: 121
2026-01-08 02:56:10,175 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2377406) oublock: 8
2026-01-08 02:56:10,175 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2377406) stime: 0.371764
2026-01-08 02:56:10,175 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2377406) utime: 0.12392099999999999
2026-01-08 02:56:10,176 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2377406) wtime: 0.541
2026-01-08 02:56:10,176 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2377406) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 4

2026-01-08 02:56:10,176 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2377406) errors:

2026-01-08 02:56:10,177 - DEBUG - ya.test.2374524  - get_binary: Binary was found by /home/runner/.ya/build/build_root/pp6n/003444/ydb/apps/ydbd/ydbd
2026-01-08 02:56:10,177 - DEBUG - ydb.tests.library.harness.kikimr_runner.2374524  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/pp6n/003444/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:7259', '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:10,179 - DEBUG - ya.test.2374524  - _get_command_output_file: Command out will be placed to ydbd.out.1
2026-01-08 02:56:10,179 - DEBUG - ya.test.2374524  - _get_command_output_file: Command err will be placed to ydbd.err.1
2026-01-08 02:56:10,179 - DEBUG - ya.test.2374524  - execute: Executing '['/home/runner/.ya/build/build_root/pp6n/003444/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:7259', '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:10,180 - DEBUG - ya.test.2374524  - execute: Command pid: 2378117
2026-01-08 02:56:10,709 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2378117) rc: 0
2026-01-08 02:56:10,709 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2378117) elapsed time (sec): 0.5275800228118896
2026-01-08 02:56:10,709 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2378117) idrss: 0
2026-01-08 02:56:10,710 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2378117) inblock: 0
2026-01-08 02:56:10,710 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2378117) isrss: 0
2026-01-08 02:56:10,710 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2378117) ixrss: 0
2026-01-08 02:56:10,710 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2378117) majflt: 0
2026-01-08 02:56:10,710 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2378117) maxrss: 564728
2026-01-08 02:56:10,711 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2378117) minflt: 18558
2026-01-08 02:56:10,711 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2378117) msgrcv: 0
2026-01-08 02:56:10,711 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2378117) msgsnd: 0
2026-01-08 02:56:10,711 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2378117) nivcsw: 3
2026-01-08 02:56:10,711 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2378117) nsignals: 0
2026-01-08 02:56:10,711 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2378117) nswap: 0
2026-01-08 02:56:10,711 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2378117) nvcsw: 114
2026-01-08 02:56:10,712 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2378117) oublock: 8
2026-01-08 02:56:10,712 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2378117) stime: 0.337661
2026-01-08 02:56:10,712 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2378117) utime: 0.146455
2026-01-08 02:56:10,712 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2378117) wtime: 0.529
2026-01-08 02:56:10,712 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2378117) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2026-01-08 02:56:10,712 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2378117) errors:

2026-01-08 02:56:10,713 - INFO - ydb.tests.library.harness.kikimr_runner.2374524  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2026-01-08 02:56:10,726 - INFO - ydb.tests.library.harness.kikimr_runner.2374524  - __run: Cluster started and initialized
2026-01-08 02:56:10,734 - DEBUG - ydb.connection.2374524  - 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:10,737 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2374524  - context_resolve: Preparing initial endpoint to resolve endpoints
2026-01-08 02:56:10,738 - DEBUG - ydb.connection.2374524  - 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:10,744 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2374524  - context_resolve: Resolving endpoints for database /Root
2026-01-08 02:56:10,745 - DEBUG - ydb.connection.2374524  - _prepare_call: RpcState(ListEndpoints, 7bc523af-2b54-42c9-99b9-d97667951e8e, localhost:7259): creating call state
2026-01-08 02:56:10,745 - DEBUG - ydb.connection.2374524  - _log_request: RpcState(ListEndpoints, 7bc523af-2b54-42c9-99b9-d97667951e8e, localhost:7259): request = { database: "/Root" }
2026-01-08 02:56:10,747 - DEBUG - ydb.connection.2374524  - _log_response: RpcState(ListEndpoints, 7bc523af-2b54-42c9-99b9-d97667951e8e, localhost:7259): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-paw7opzmb4.auto.internal" port: 7259 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:10,748 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2374524  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-paw7opzmb4.auto.internal:7259, location 1, ssl: False>]>
2026-01-08 02:56:10,748 - DEBUG - ydb.connection.2374524  - 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:10,754 - DEBUG - ydb.connection.2374524  - close: Closing channel for endpoint localhost:7259
2026-01-08 02:56:10,755 - DEBUG - ydb.connection.2374524  - _prepare_call: RpcState(CreateSession, 0cc98f57-6be0-48a3-82e7-89921abbb296, ghrun-paw7opzmb4.auto.internal:7259): creating call state
2026-01-08 02:56:10,756 - DEBUG - ydb.connection.2374524  - _log_request: RpcState(CreateSession, 0cc98f57-6be0-48a3-82e7-89921abbb296, ghrun-paw7opzmb4.auto.internal:7259): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2026-01-08 02:56:10,758 - DEBUG - ydb.connection.2374524  - _log_response: RpcState(CreateSession, 0cc98f57-6be0-48a3-82e7-89921abbb296, ghrun-paw7opzmb4.auto.internal:7259): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=NDlkMDhhNDctYjk5MmJkZjMtZTgzZmE5MS0zOWZhMmFmMw==" } } } }
2026-01-08 02:56:10,761 - INFO - ya.test.2374524  - pytest_runtest_call: Test call (class_name: test_ydb_impex.py::TestImpex, test_name: test_multiple_files[tsv-additional_args2-column])
2026-01-08 02:56:10,762 - DEBUG - ydb.connection.2374524  - _prepare_call: RpcState(ExecuteSchemeQuery, 3ec34e3e-67a2-4103-a0c0-5f38ca7019a8, ghrun-paw7opzmb4.auto.internal:7259): creating call state
2026-01-08 02:56:10,762 - DEBUG - ydb.connection.2374524  - _log_request: RpcState(ExecuteSchemeQuery, 3ec34e3e-67a2-4103-a0c0-5f38ca7019a8, ghrun-paw7opzmb4.auto.internal:7259): request = { session_id: "ydb://session/3?node_id=1&id=NDlkMDhhNDctYjk5MmJkZjMtZTgzZmE5MS0zOWZhMmFmMw==" yql_text: "\n        CREATE TABLE `/Root/test_multiple_files[tsv-additional_args2-column]` (\n            key Uint32 NOT NULL,\n            id Uint64,\n            value Utf8,\n            PRIMARY KEY(key)\n        )\n        PARTITION BY HASH(key)\n        WITH (\n            STORE = column\n        )\n        " operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2026-01-08 02:56:11,040 - DEBUG - ydb.connection.2374524  - _log_response: RpcState(ExecuteSchemeQuery, 3ec34e3e-67a2-4103-a0c0-5f38ca7019a8, ghrun-paw7opzmb4.auto.internal:7259): response = { operation { ready: true status: SUCCESS } }
2026-01-08 02:56:11,041 - DEBUG - ya.test.2374524  - get_binary: Binary was found by /home/runner/.ya/build/build_root/pp6n/003444/ydb/apps/ydb/ydb
2026-01-08 02:56:11,042 - DEBUG - ya.test.2374524  - _get_command_output_file: Command out will be placed to ydb.out
2026-01-08 02:56:11,042 - DEBUG - ya.test.2374524  - _get_command_output_file: Command err will be placed to ydb.err
2026-01-08 02:56:11,043 - DEBUG - ya.test.2374524  - execute: Executing '['/home/runner/.ya/build/build_root/pp6n/003444/ydb/apps/ydb/ydb', '--endpoint', 'grpc://localhost:7259', '--database', '/Root', 'import', 'file', 'tsv', '-p', '/Root/test_multiple_files[tsv-additional_args2-column]', '--header', '/home/runner/.ya/build/build_root/pp6n/003444/tmp/test_multiple_files_tsv_additi0/tempinput0.tsv', '/home/runner/.ya/build/build_root/pp6n/003444/tmp/test_multiple_files_tsv_additi0/tempinput1.tsv', '/home/runner/.ya/build/build_root/pp6n/003444/tmp/test_multiple_files_tsv_additi0/tempinput2.tsv', '/home/runner/.ya/build/build_root/pp6n/003444/tmp/test_multiple_files_tsv_additi0/tempinput3.tsv']' in 'None' (waiting)
2026-01-08 02:56:11,043 - DEBUG - ya.test.2374524  - execute: Command pid: 2379614
2026-01-08 02:56:11,208 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2379614) rc: 0
2026-01-08 02:56:11,209 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2379614) elapsed time (sec): 0.16446781158447266
2026-01-08 02:56:11,209 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2379614) idrss: 0
2026-01-08 02:56:11,209 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2379614) inblock: 0
2026-01-08 02:56:11,209 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2379614) isrss: 0
2026-01-08 02:56:11,209 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2379614) ixrss: 0
2026-01-08 02:56:11,209 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2379614) majflt: 0
2026-01-08 02:56:11,209 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2379614) maxrss: 180936
2026-01-08 02:56:11,210 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2379614) minflt: 4270
2026-01-08 02:56:11,210 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2379614) msgrcv: 0
2026-01-08 02:56:11,210 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2379614) msgsnd: 0
2026-01-08 02:56:11,210 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2379614) nivcsw: 1
2026-01-08 02:56:11,210 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2379614) nsignals: 0
2026-01-08 02:56:11,210 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2379614) nswap: 0
2026-01-08 02:56:11,210 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2379614) nvcsw: 537
2026-01-08 02:56:11,210 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2379614) oublock: 80
2026-01-08 02:56:11,210 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2379614) stime: 0.036682
2026-01-08 02:56:11,210 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2379614) utime: 0.045853
2026-01-08 02:56:11,211 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2379614) wtime: 0.165
2026-01-08 02:56:11,211 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2379614) output:

2026-01-08 02:56:11,211 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2379614) errors:
Elapsed: 0.0435 sec. Total read size: 290B. Average processing speed: 6.51KiB/s.


2026-01-08 02:56:11,211 - DEBUG - __tests__.test_ydb_impex.2374524  - execute_ydb_cli_command: std_out:

2026-01-08 02:56:11,211 - DEBUG - ya.test.2374524  - get_binary: Binary was found by /home/runner/.ya/build/build_root/pp6n/003444/ydb/apps/ydb/ydb
2026-01-08 02:56:11,212 - DEBUG - ya.test.2374524  - _get_command_output_file: Command err will be placed to ydb.err.0
2026-01-08 02:56:11,212 - DEBUG - ya.test.2374524  - execute: Executing '['/home/runner/.ya/build/build_root/pp6n/003444/ydb/apps/ydb/ydb', '--endpoint', 'grpc://localhost:7259', '--database', '/Root', 'table', 'query', 'execute', '-q', 'SELECT `key`, `id`, `value` FROM `/Root/test_multiple_files[tsv-additional_args2-column]` ORDER BY `key`', '-t', 'scan', '--format', 'tsv']' in 'None' (waiting)
2026-01-08 02:56:11,213 - DEBUG - ya.test.2374524  - execute: Command pid: 2380067
2026-01-08 02:56:11,384 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2380067) rc: 0
2026-01-08 02:56:11,384 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2380067) elapsed time (sec): 0.1701517105102539
2026-01-08 02:56:11,384 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2380067) idrss: 0
2026-01-08 02:56:11,384 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2380067) inblock: 0
2026-01-08 02:56:11,384 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2380067) isrss: 0
2026-01-08 02:56:11,384 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2380067) ixrss: 0
2026-01-08 02:56:11,385 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2380067) majflt: 0
2026-01-08 02:56:11,385 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2380067) maxrss: 180936
2026-01-08 02:56:11,385 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2380067) minflt: 3562
2026-01-08 02:56:11,385 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2380067) msgrcv: 0
2026-01-08 02:56:11,385 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2380067) msgsnd: 0
2026-01-08 02:56:11,385 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2380067) nivcsw: 2
2026-01-08 02:56:11,385 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2380067) nsignals: 0
2026-01-08 02:56:11,385 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2380067) nswap: 0
2026-01-08 02:56:11,386 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2380067) nvcsw: 189
2026-01-08 02:56:11,386 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2380067) oublock: 8
2026-01-08 02:56:11,386 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2380067) stime: 0.017414
2026-01-08 02:56:11,386 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2380067) utime: 0.034828
2026-01-08 02:56:11,386 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2380067) wtime: 0.171
2026-01-08 02:56:11,386 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2380067) 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:11,386 - DEBUG - ya.test.2374524  - _save_outputs: Command (pid 2380067) errors:

2026-01-08 02:56:11,386 - DEBUG - __tests__.test_ydb_impex.2374524  - 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:11,388 - INFO - ya.test.2374524  - pytest_runtest_teardown: Test teardown
2026-01-08 02:56:34,584 - DEBUG - ya.test - _verify_test: Verifying [test_ydb_impex.TestImpex.test_multiple_files[tsv-additional_args2-column] in ydb/tests/functional/ydb_cli] canonical results
2026-01-08 02:56:34,588 - DEBUG - ya.test - verify: Test test_ydb_impex.TestImpex.test_multiple_files[tsv-additional_args2-column] status: good
