2025-10-31 15:31:17,610 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-31 15:31:17,610 - INFO - ya.test - pytest_runtest_setup: test_multiple_files_and_stdin[tsv-additional_args3-row]
2025-10-31 15:31:17,610 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-31 15:31:17,610 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-31 15:31:17,668 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/stm2/00305d/ydb/apps/ydbd/ydbd
2025-10-31 15:31:17,669 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/30230
2025-10-31 15:31:17,670 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/stm2/00305d/r3tmp/kikimr_cluster_1h526vk0
2025-10-31 15:31:17,702 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/stm2/00305d/ydb/apps/ydbd/ydbd
2025-10-31 15:31:17,702 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/4260
2025-10-31 15:31:17,703 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/5807
2025-10-31 15:31:17,703 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/14286
2025-10-31 15:31:17,703 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/1159
2025-10-31 15:31:17,704 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/stm2/00305d/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk23/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files_and_stdin.tsv-additional_args3-row/cluster/kikimr_configs"
2025-10-31 15:31:17,704 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/stm2/00305d/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/stm2/00305d/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk23/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files_and_stdin.tsv-additional_args3-row/cluster/node_1/logfile_ev6f1m43.log --grpc-port=4260 --mon-port=5807 --ic-port=30230
2025-10-31 15:31:17,705 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:4260/1, disk_size 68719476736
2025-10-31 15:31:17,705 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/stm2/00305d/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk23/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files_and_stdin.tsv-additional_args3-row/cluster/kikimr_configs"
2025-10-31 15:31:17,705 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/stm2/00305d/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/stm2/00305d/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk23/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files_and_stdin.tsv-additional_args3-row/cluster/node_1/logfile_ev6f1m43.log --grpc-port=4260 --mon-port=5807 --ic-port=30230
2025-10-31 15:31:17,706 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/stm2/00305d/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/stm2/00305d/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk23/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files_and_stdin.tsv-additional_args3-row/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/stm2/00305d/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk23/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files_and_stdin.tsv-additional_args3-row/cluster/node_1/logfile_ev6f1m43.log', '--grpc-port=4260', '--mon-port=5807', '--ic-port=30230')' in '/home/runner/.ya/build/build_root/stm2/00305d/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk23/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files_and_stdin.tsv-additional_args3-row/cluster/node_1' (no wait)
2025-10-31 15:31:17,707 - DEBUG - ya.test - execute: Command pid: 2657450
2025-10-31 15:31:17,708 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:4260/1
2025-10-31 15:31:17,709 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-10-31 15:31:17,709 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-10-31 15:31:17,709 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/stm2/00305d/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-31 15:31:17,710 - DEBUG - ya.test - execute: Command pid: 2657451
2025-10-31 15:31:18,253 - DEBUG - ya.test - _save_outputs: Command (pid 2657451) rc: 0
2025-10-31 15:31:18,253 - DEBUG - ya.test - _save_outputs: Command (pid 2657451) elapsed time (sec): 0.5424420833587646
2025-10-31 15:31:18,254 - DEBUG - ya.test - _save_outputs: Command (pid 2657451) idrss: 0
2025-10-31 15:31:18,254 - DEBUG - ya.test - _save_outputs: Command (pid 2657451) inblock: 0
2025-10-31 15:31:18,254 - DEBUG - ya.test - _save_outputs: Command (pid 2657451) isrss: 0
2025-10-31 15:31:18,254 - DEBUG - ya.test - _save_outputs: Command (pid 2657451) ixrss: 0
2025-10-31 15:31:18,254 - DEBUG - ya.test - _save_outputs: Command (pid 2657451) majflt: 0
2025-10-31 15:31:18,254 - DEBUG - ya.test - _save_outputs: Command (pid 2657451) maxrss: 538348
2025-10-31 15:31:18,254 - DEBUG - ya.test - _save_outputs: Command (pid 2657451) minflt: 16132
2025-10-31 15:31:18,254 - DEBUG - ya.test - _save_outputs: Command (pid 2657451) msgrcv: 0
2025-10-31 15:31:18,255 - DEBUG - ya.test - _save_outputs: Command (pid 2657451) msgsnd: 0
2025-10-31 15:31:18,255 - DEBUG - ya.test - _save_outputs: Command (pid 2657451) nivcsw: 3
2025-10-31 15:31:18,255 - DEBUG - ya.test - _save_outputs: Command (pid 2657451) nsignals: 0
2025-10-31 15:31:18,255 - DEBUG - ya.test - _save_outputs: Command (pid 2657451) nswap: 0
2025-10-31 15:31:18,255 - DEBUG - ya.test - _save_outputs: Command (pid 2657451) nvcsw: 15
2025-10-31 15:31:18,255 - DEBUG - ya.test - _save_outputs: Command (pid 2657451) oublock: 8
2025-10-31 15:31:18,255 - DEBUG - ya.test - _save_outputs: Command (pid 2657451) stime: 0.387652
2025-10-31 15:31:18,255 - DEBUG - ya.test - _save_outputs: Command (pid 2657451) utime: 0.106802
2025-10-31 15:31:18,256 - DEBUG - ya.test - _save_outputs: Command (pid 2657451) wtime: 0.543
2025-10-31 15:31:18,256 - DEBUG - ya.test - _save_outputs: Command (pid 2657451) output:
Git info:
    Commit: b78d702ce2f71e40f285a60704f6a28670ea8340
    Branch: 
    Author: kungurtsev <alexey66rus@gmail.com>
    Summary: Merge f10023174585e1f3e64dac76a090d0c070f4c2a5 into 4af0266bcdc7df80879f060afb0976424f2118ed

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

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

2025-10-31 15:31:18,256 - DEBUG - ya.test - _save_outputs: Command (pid 2657451) errors:

2025-10-31 15:31:18,256 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: b78d702ce2f71e40f285a60704f6a28670ea8340
    Branch: 
    Author: kungurtsev <alexey66rus@gmail.com>
    Summary: Merge f10023174585e1f3e64dac76a090d0c070f4c2a5 into 4af0266bcdc7df80879f060afb0976424f2118ed
2025-10-31 15:31:20,188 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/stm2/00305d/ydb/apps/ydbd/ydbd
2025-10-31 15:31:20,188 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/stm2/00305d/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:4260', '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: 30230\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-10-31 15:31:20,189 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-10-31 15:31:20,190 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-10-31 15:31:20,190 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/stm2/00305d/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:4260', '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: 30230\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-10-31 15:31:20,191 - DEBUG - ya.test - execute: Command pid: 2658437
2025-10-31 15:31:20,649 - DEBUG - ya.test - _save_outputs: Command (pid 2658437) rc: 0
2025-10-31 15:31:20,649 - DEBUG - ya.test - _save_outputs: Command (pid 2658437) elapsed time (sec): 0.4565114974975586
2025-10-31 15:31:20,649 - DEBUG - ya.test - _save_outputs: Command (pid 2658437) idrss: 0
2025-10-31 15:31:20,650 - DEBUG - ya.test - _save_outputs: Command (pid 2658437) inblock: 0
2025-10-31 15:31:20,650 - DEBUG - ya.test - _save_outputs: Command (pid 2658437) isrss: 0
2025-10-31 15:31:20,650 - DEBUG - ya.test - _save_outputs: Command (pid 2658437) ixrss: 0
2025-10-31 15:31:20,650 - DEBUG - ya.test - _save_outputs: Command (pid 2658437) majflt: 0
2025-10-31 15:31:20,650 - DEBUG - ya.test - _save_outputs: Command (pid 2658437) maxrss: 546828
2025-10-31 15:31:20,651 - DEBUG - ya.test - _save_outputs: Command (pid 2658437) minflt: 18274
2025-10-31 15:31:20,651 - DEBUG - ya.test - _save_outputs: Command (pid 2658437) msgrcv: 0
2025-10-31 15:31:20,651 - DEBUG - ya.test - _save_outputs: Command (pid 2658437) msgsnd: 0
2025-10-31 15:31:20,651 - DEBUG - ya.test - _save_outputs: Command (pid 2658437) nivcsw: 1
2025-10-31 15:31:20,651 - DEBUG - ya.test - _save_outputs: Command (pid 2658437) nsignals: 0
2025-10-31 15:31:20,651 - DEBUG - ya.test - _save_outputs: Command (pid 2658437) nswap: 0
2025-10-31 15:31:20,651 - DEBUG - ya.test - _save_outputs: Command (pid 2658437) nvcsw: 151
2025-10-31 15:31:20,652 - DEBUG - ya.test - _save_outputs: Command (pid 2658437) oublock: 8
2025-10-31 15:31:20,652 - DEBUG - ya.test - _save_outputs: Command (pid 2658437) stime: 0.294696
2025-10-31 15:31:20,652 - DEBUG - ya.test - _save_outputs: Command (pid 2658437) utime: 0.119471
2025-10-31 15:31:20,652 - DEBUG - ya.test - _save_outputs: Command (pid 2658437) wtime: 0.458
2025-10-31 15:31:20,652 - DEBUG - ya.test - _save_outputs: Command (pid 2658437) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 4

2025-10-31 15:31:20,652 - DEBUG - ya.test - _save_outputs: Command (pid 2658437) errors:

2025-10-31 15:31:20,653 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/stm2/00305d/ydb/apps/ydbd/ydbd
2025-10-31 15:31:20,653 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/stm2/00305d/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:4260', '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-31 15:31:20,654 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-10-31 15:31:20,655 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-10-31 15:31:20,655 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/stm2/00305d/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:4260', '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-31 15:31:20,656 - DEBUG - ya.test - execute: Command pid: 2658586
2025-10-31 15:31:21,078 - DEBUG - ya.test - _save_outputs: Command (pid 2658586) rc: 0
2025-10-31 15:31:21,078 - DEBUG - ya.test - _save_outputs: Command (pid 2658586) elapsed time (sec): 0.42134761810302734
2025-10-31 15:31:21,078 - DEBUG - ya.test - _save_outputs: Command (pid 2658586) idrss: 0
2025-10-31 15:31:21,078 - DEBUG - ya.test - _save_outputs: Command (pid 2658586) inblock: 0
2025-10-31 15:31:21,078 - DEBUG - ya.test - _save_outputs: Command (pid 2658586) isrss: 0
2025-10-31 15:31:21,079 - DEBUG - ya.test - _save_outputs: Command (pid 2658586) ixrss: 0
2025-10-31 15:31:21,079 - DEBUG - ya.test - _save_outputs: Command (pid 2658586) majflt: 0
2025-10-31 15:31:21,079 - DEBUG - ya.test - _save_outputs: Command (pid 2658586) maxrss: 546832
2025-10-31 15:31:21,079 - DEBUG - ya.test - _save_outputs: Command (pid 2658586) minflt: 18273
2025-10-31 15:31:21,079 - DEBUG - ya.test - _save_outputs: Command (pid 2658586) msgrcv: 0
2025-10-31 15:31:21,079 - DEBUG - ya.test - _save_outputs: Command (pid 2658586) msgsnd: 0
2025-10-31 15:31:21,080 - DEBUG - ya.test - _save_outputs: Command (pid 2658586) nivcsw: 4
2025-10-31 15:31:21,080 - DEBUG - ya.test - _save_outputs: Command (pid 2658586) nsignals: 0
2025-10-31 15:31:21,080 - DEBUG - ya.test - _save_outputs: Command (pid 2658586) nswap: 0
2025-10-31 15:31:21,080 - DEBUG - ya.test - _save_outputs: Command (pid 2658586) nvcsw: 154
2025-10-31 15:31:21,080 - DEBUG - ya.test - _save_outputs: Command (pid 2658586) oublock: 8
2025-10-31 15:31:21,080 - DEBUG - ya.test - _save_outputs: Command (pid 2658586) stime: 0.263015
2025-10-31 15:31:21,080 - DEBUG - ya.test - _save_outputs: Command (pid 2658586) utime: 0.11556699999999999
2025-10-31 15:31:21,081 - DEBUG - ya.test - _save_outputs: Command (pid 2658586) wtime: 0.422
2025-10-31 15:31:21,081 - DEBUG - ya.test - _save_outputs: Command (pid 2658586) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-10-31 15:31:21,081 - DEBUG - ya.test - _save_outputs: Command (pid 2658586) errors:

2025-10-31 15:31:21,081 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-10-31 15:31:21,097 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-10-31 15:31:21,106 - 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-10-31 15:31:21,108 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 15:31:21,115 - 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-10-31 15:31:21,123 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-10-31 15:31:21,124 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 2546ad8b-ea04-4928-84e4-1fca871b237c, localhost:4260): creating call state
2025-10-31 15:31:21,124 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 2546ad8b-ea04-4928-84e4-1fca871b237c, localhost:4260): request = { database: "/Root" }
2025-10-31 15:31:21,127 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 2546ad8b-ea04-4928-84e4-1fca871b237c, localhost:4260): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-upzbhs6y6e.auto.internal" port: 4260 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-10-31 15:31:21,128 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-upzbhs6y6e.auto.internal:4260, location 1, ssl: False>]>
2025-10-31 15:31:21,129 - 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-10-31 15:31:21,136 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:4260
2025-10-31 15:31:21,137 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, ab59fbb2-a9dc-4cd6-a6a4-253f2014e5e3, ghrun-upzbhs6y6e.auto.internal:4260): creating call state
2025-10-31 15:31:21,137 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, ab59fbb2-a9dc-4cd6-a6a4-253f2014e5e3, ghrun-upzbhs6y6e.auto.internal:4260): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 15:31:21,139 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, ab59fbb2-a9dc-4cd6-a6a4-253f2014e5e3, ghrun-upzbhs6y6e.auto.internal:4260): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=YjllZDU4OTEtNzg2Y2E5Y2QtYTQ1N2IwZmQtOWViMjBkMjk=" } } } }
2025-10-31 15:31:21,142 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_ydb_impex.py::TestImpex, test_name: test_multiple_files_and_stdin[tsv-additional_args3-row])
2025-10-31 15:31:21,143 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, 8feb311b-b682-4d35-90cf-6c6e692e0cf7, ghrun-upzbhs6y6e.auto.internal:4260): creating call state
2025-10-31 15:31:21,144 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, 8feb311b-b682-4d35-90cf-6c6e692e0cf7, ghrun-upzbhs6y6e.auto.internal:4260): request = { session_id: "ydb://session/3?node_id=1&id=YjllZDU4OTEtNzg2Y2E5Y2QtYTQ1N2IwZmQtOWViMjBkMjk=" yql_text: "\n        CREATE TABLE `/Root/test_multiple_files_and_stdin[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 } } }
2025-10-31 15:31:21,176 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, 8feb311b-b682-4d35-90cf-6c6e692e0cf7, ghrun-upzbhs6y6e.auto.internal:4260): response = { operation { ready: true status: SUCCESS } }
2025-10-31 15:31:21,178 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/stm2/00305d/ydb/apps/ydb/ydb
2025-10-31 15:31:21,178 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out
2025-10-31 15:31:21,179 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err
2025-10-31 15:31:21,179 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/stm2/00305d/ydb/apps/ydb/ydb', '--endpoint', 'grpc://localhost:4260', '--database', '/Root', 'import', 'file', 'tsv', '-p', '/Root/test_multiple_files_and_stdin[tsv-additional_args3-row]', '--header', '--newline-delimited', '/home/runner/.ya/build/build_root/stm2/00305d/tmp/test_multiple_files_and_stdin_0/tempinput0.tsv', '/home/runner/.ya/build/build_root/stm2/00305d/tmp/test_multiple_files_and_stdin_0/tempinput1.tsv', '/home/runner/.ya/build/build_root/stm2/00305d/tmp/test_multiple_files_and_stdin_0/tempinput2.tsv', '/home/runner/.ya/build/build_root/stm2/00305d/tmp/test_multiple_files_and_stdin_0/tempinput3.tsv']' in 'None' (waiting)
2025-10-31 15:31:21,180 - DEBUG - ya.test - execute: Command pid: 2658881
2025-10-31 15:31:21,328 - DEBUG - ya.test - _save_outputs: Command (pid 2658881) rc: 0
2025-10-31 15:31:21,328 - DEBUG - ya.test - _save_outputs: Command (pid 2658881) elapsed time (sec): 0.14710092544555664
2025-10-31 15:31:21,328 - DEBUG - ya.test - _save_outputs: Command (pid 2658881) idrss: 0
2025-10-31 15:31:21,328 - DEBUG - ya.test - _save_outputs: Command (pid 2658881) inblock: 0
2025-10-31 15:31:21,328 - DEBUG - ya.test - _save_outputs: Command (pid 2658881) isrss: 0
2025-10-31 15:31:21,328 - DEBUG - ya.test - _save_outputs: Command (pid 2658881) ixrss: 0
2025-10-31 15:31:21,329 - DEBUG - ya.test - _save_outputs: Command (pid 2658881) majflt: 0
2025-10-31 15:31:21,329 - DEBUG - ya.test - _save_outputs: Command (pid 2658881) maxrss: 184400
2025-10-31 15:31:21,329 - DEBUG - ya.test - _save_outputs: Command (pid 2658881) minflt: 4419
2025-10-31 15:31:21,329 - DEBUG - ya.test - _save_outputs: Command (pid 2658881) msgrcv: 0
2025-10-31 15:31:21,329 - DEBUG - ya.test - _save_outputs: Command (pid 2658881) msgsnd: 0
2025-10-31 15:31:21,329 - DEBUG - ya.test - _save_outputs: Command (pid 2658881) nivcsw: 47
2025-10-31 15:31:21,329 - DEBUG - ya.test - _save_outputs: Command (pid 2658881) nsignals: 0
2025-10-31 15:31:21,330 - DEBUG - ya.test - _save_outputs: Command (pid 2658881) nswap: 0
2025-10-31 15:31:21,330 - DEBUG - ya.test - _save_outputs: Command (pid 2658881) nvcsw: 911
2025-10-31 15:31:21,330 - DEBUG - ya.test - _save_outputs: Command (pid 2658881) oublock: 48
2025-10-31 15:31:21,330 - DEBUG - ya.test - _save_outputs: Command (pid 2658881) stime: 0.051094999999999995
2025-10-31 15:31:21,330 - DEBUG - ya.test - _save_outputs: Command (pid 2658881) utime: 0.043234999999999996
2025-10-31 15:31:21,330 - DEBUG - ya.test - _save_outputs: Command (pid 2658881) wtime: 0.148
2025-10-31 15:31:21,331 - DEBUG - ya.test - _save_outputs: Command (pid 2658881) output:

2025-10-31 15:31:21,331 - DEBUG - ya.test - _save_outputs: Command (pid 2658881) errors:
Elapsed: 0.00687 sec. Total read size: 290B. Average processing speed: 41.2KiB/s.


2025-10-31 15:31:21,331 - DEBUG - __tests__.test_ydb_impex - execute_ydb_cli_command: std_out:

2025-10-31 15:31:21,331 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/stm2/00305d/ydb/apps/ydb/ydb
2025-10-31 15:31:21,332 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.0
2025-10-31 15:31:21,332 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/stm2/00305d/ydb/apps/ydb/ydb', '--endpoint', 'grpc://localhost:4260', '--database', '/Root', 'table', 'query', 'execute', '-q', 'SELECT `key`, `id`, `value` FROM `/Root/test_multiple_files_and_stdin[tsv-additional_args3-row]` ORDER BY `key`', '-t', 'scan', '--format', 'tsv']' in 'None' (waiting)
2025-10-31 15:31:21,333 - DEBUG - ya.test - execute: Command pid: 2659133
2025-10-31 15:31:21,465 - DEBUG - ya.test - _save_outputs: Command (pid 2659133) rc: 0
2025-10-31 15:31:21,466 - DEBUG - ya.test - _save_outputs: Command (pid 2659133) elapsed time (sec): 0.1312856674194336
2025-10-31 15:31:21,466 - DEBUG - ya.test - _save_outputs: Command (pid 2659133) idrss: 0
2025-10-31 15:31:21,466 - DEBUG - ya.test - _save_outputs: Command (pid 2659133) inblock: 0
2025-10-31 15:31:21,466 - DEBUG - ya.test - _save_outputs: Command (pid 2659133) isrss: 0
2025-10-31 15:31:21,466 - DEBUG - ya.test - _save_outputs: Command (pid 2659133) ixrss: 0
2025-10-31 15:31:21,466 - DEBUG - ya.test - _save_outputs: Command (pid 2659133) majflt: 0
2025-10-31 15:31:21,466 - DEBUG - ya.test - _save_outputs: Command (pid 2659133) maxrss: 184400
2025-10-31 15:31:21,467 - DEBUG - ya.test - _save_outputs: Command (pid 2659133) minflt: 3445
2025-10-31 15:31:21,467 - DEBUG - ya.test - _save_outputs: Command (pid 2659133) msgrcv: 0
2025-10-31 15:31:21,467 - DEBUG - ya.test - _save_outputs: Command (pid 2659133) msgsnd: 0
2025-10-31 15:31:21,467 - DEBUG - ya.test - _save_outputs: Command (pid 2659133) nivcsw: 0
2025-10-31 15:31:21,467 - DEBUG - ya.test - _save_outputs: Command (pid 2659133) nsignals: 0
2025-10-31 15:31:21,467 - DEBUG - ya.test - _save_outputs: Command (pid 2659133) nswap: 0
2025-10-31 15:31:21,467 - DEBUG - ya.test - _save_outputs: Command (pid 2659133) nvcsw: 179
2025-10-31 15:31:21,468 - DEBUG - ya.test - _save_outputs: Command (pid 2659133) oublock: 8
2025-10-31 15:31:21,468 - DEBUG - ya.test - _save_outputs: Command (pid 2659133) stime: 0.013744
2025-10-31 15:31:21,468 - DEBUG - ya.test - _save_outputs: Command (pid 2659133) utime: 0.048104
2025-10-31 15:31:21,468 - DEBUG - ya.test - _save_outputs: Command (pid 2659133) wtime: 0.132
2025-10-31 15:31:21,468 - DEBUG - ya.test - _save_outputs: Command (pid 2659133) 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"

2025-10-31 15:31:21,468 - DEBUG - ya.test - _save_outputs: Command (pid 2659133) errors:

2025-10-31 15:31:21,469 - DEBUG - __tests__.test_ydb_impex - 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"

2025-10-31 15:31:21,470 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-10-31 15:31:45,039 - DEBUG - ya.test - _verify_test: Verifying [test_ydb_impex.TestImpex.test_multiple_files_and_stdin[tsv-additional_args3-row] in ydb/tests/functional/ydb_cli] canonical results
2025-10-31 15:31:45,056 - DEBUG - ya.test - verify: Test test_ydb_impex.TestImpex.test_multiple_files_and_stdin[tsv-additional_args3-row] status: good
