2025-10-31 15:39:44,666 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-31 15:39:44,667 - INFO - ya.test - pytest_runtest_setup: test_multiple_files_and_stdin[tsv-additional_args2-column]
2025-10-31 15:39:44,667 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-31 15:39:44,667 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-31 15:39:44,740 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/stm2/002faa/ydb/apps/ydbd/ydbd
2025-10-31 15:39:44,741 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/16334
2025-10-31 15:39:44,742 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/stm2/002faa/r3tmp/kikimr_cluster_20zo380h
2025-10-31 15:39:44,786 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/stm2/002faa/ydb/apps/ydbd/ydbd
2025-10-31 15:39:44,787 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/28790
2025-10-31 15:39:44,788 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/8179
2025-10-31 15:39:44,788 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/6934
2025-10-31 15:39:44,789 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/9913
2025-10-31 15:39:44,790 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/stm2/002faa/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk22/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files_and_stdin.tsv-additional_args2-column/cluster/kikimr_configs"
2025-10-31 15:39:44,790 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/stm2/002faa/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/002faa/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk22/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files_and_stdin.tsv-additional_args2-column/cluster/node_1/logfile_i3zpstdt.log --grpc-port=28790 --mon-port=8179 --ic-port=16334
2025-10-31 15:39:44,791 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:28790/1, disk_size 68719476736
2025-10-31 15:39:44,791 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/stm2/002faa/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk22/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files_and_stdin.tsv-additional_args2-column/cluster/kikimr_configs"
2025-10-31 15:39:44,792 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/stm2/002faa/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/002faa/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk22/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files_and_stdin.tsv-additional_args2-column/cluster/node_1/logfile_i3zpstdt.log --grpc-port=28790 --mon-port=8179 --ic-port=16334
2025-10-31 15:39:44,794 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/stm2/002faa/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/stm2/002faa/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk22/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files_and_stdin.tsv-additional_args2-column/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/stm2/002faa/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk22/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files_and_stdin.tsv-additional_args2-column/cluster/node_1/logfile_i3zpstdt.log', '--grpc-port=28790', '--mon-port=8179', '--ic-port=16334')' in '/home/runner/.ya/build/build_root/stm2/002faa/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk22/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files_and_stdin.tsv-additional_args2-column/cluster/node_1' (no wait)
2025-10-31 15:39:44,808 - DEBUG - ya.test - execute: Command pid: 3012817
2025-10-31 15:39:44,809 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:28790/1
2025-10-31 15:39:44,817 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-10-31 15:39:44,832 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-10-31 15:39:44,833 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/stm2/002faa/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-31 15:39:44,836 - DEBUG - ya.test - execute: Command pid: 3012819
2025-10-31 15:39:45,385 - DEBUG - ya.test - _save_outputs: Command (pid 3012819) rc: 0
2025-10-31 15:39:45,386 - DEBUG - ya.test - _save_outputs: Command (pid 3012819) elapsed time (sec): 0.5486505031585693
2025-10-31 15:39:45,386 - DEBUG - ya.test - _save_outputs: Command (pid 3012819) idrss: 0
2025-10-31 15:39:45,386 - DEBUG - ya.test - _save_outputs: Command (pid 3012819) inblock: 0
2025-10-31 15:39:45,386 - DEBUG - ya.test - _save_outputs: Command (pid 3012819) isrss: 0
2025-10-31 15:39:45,386 - DEBUG - ya.test - _save_outputs: Command (pid 3012819) ixrss: 0
2025-10-31 15:39:45,387 - DEBUG - ya.test - _save_outputs: Command (pid 3012819) majflt: 0
2025-10-31 15:39:45,387 - DEBUG - ya.test - _save_outputs: Command (pid 3012819) maxrss: 538348
2025-10-31 15:39:45,387 - DEBUG - ya.test - _save_outputs: Command (pid 3012819) minflt: 16132
2025-10-31 15:39:45,387 - DEBUG - ya.test - _save_outputs: Command (pid 3012819) msgrcv: 0
2025-10-31 15:39:45,387 - DEBUG - ya.test - _save_outputs: Command (pid 3012819) msgsnd: 0
2025-10-31 15:39:45,388 - DEBUG - ya.test - _save_outputs: Command (pid 3012819) nivcsw: 140
2025-10-31 15:39:45,388 - DEBUG - ya.test - _save_outputs: Command (pid 3012819) nsignals: 0
2025-10-31 15:39:45,388 - DEBUG - ya.test - _save_outputs: Command (pid 3012819) nswap: 0
2025-10-31 15:39:45,388 - DEBUG - ya.test - _save_outputs: Command (pid 3012819) nvcsw: 18
2025-10-31 15:39:45,388 - DEBUG - ya.test - _save_outputs: Command (pid 3012819) oublock: 8
2025-10-31 15:39:45,388 - DEBUG - ya.test - _save_outputs: Command (pid 3012819) stime: 0.310121
2025-10-31 15:39:45,389 - DEBUG - ya.test - _save_outputs: Command (pid 3012819) utime: 0.115288
2025-10-31 15:39:45,389 - DEBUG - ya.test - _save_outputs: Command (pid 3012819) wtime: 0.552
2025-10-31 15:39:45,389 - DEBUG - ya.test - _save_outputs: Command (pid 3012819) 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:39:45,389 - DEBUG - ya.test - _save_outputs: Command (pid 3012819) errors:

2025-10-31 15:39:45,390 - 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:39:47,421 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/stm2/002faa/ydb/apps/ydbd/ydbd
2025-10-31 15:39:47,421 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/stm2/002faa/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:28790', '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: 16334\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-10-31 15:39:47,422 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-10-31 15:39:47,423 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-10-31 15:39:47,423 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/stm2/002faa/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:28790', '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: 16334\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-10-31 15:39:47,425 - DEBUG - ya.test - execute: Command pid: 3014170
2025-10-31 15:39:47,992 - DEBUG - ya.test - _save_outputs: Command (pid 3014170) rc: 0
2025-10-31 15:39:47,993 - DEBUG - ya.test - _save_outputs: Command (pid 3014170) elapsed time (sec): 0.5625450611114502
2025-10-31 15:39:47,993 - DEBUG - ya.test - _save_outputs: Command (pid 3014170) idrss: 0
2025-10-31 15:39:47,993 - DEBUG - ya.test - _save_outputs: Command (pid 3014170) inblock: 0
2025-10-31 15:39:47,994 - DEBUG - ya.test - _save_outputs: Command (pid 3014170) isrss: 0
2025-10-31 15:39:47,994 - DEBUG - ya.test - _save_outputs: Command (pid 3014170) ixrss: 0
2025-10-31 15:39:47,994 - DEBUG - ya.test - _save_outputs: Command (pid 3014170) majflt: 0
2025-10-31 15:39:47,995 - DEBUG - ya.test - _save_outputs: Command (pid 3014170) maxrss: 546808
2025-10-31 15:39:47,995 - DEBUG - ya.test - _save_outputs: Command (pid 3014170) minflt: 18273
2025-10-31 15:39:47,996 - DEBUG - ya.test - _save_outputs: Command (pid 3014170) msgrcv: 0
2025-10-31 15:39:47,996 - DEBUG - ya.test - _save_outputs: Command (pid 3014170) msgsnd: 0
2025-10-31 15:39:47,996 - DEBUG - ya.test - _save_outputs: Command (pid 3014170) nivcsw: 101
2025-10-31 15:39:47,997 - DEBUG - ya.test - _save_outputs: Command (pid 3014170) nsignals: 0
2025-10-31 15:39:47,997 - DEBUG - ya.test - _save_outputs: Command (pid 3014170) nswap: 0
2025-10-31 15:39:47,997 - DEBUG - ya.test - _save_outputs: Command (pid 3014170) nvcsw: 125
2025-10-31 15:39:47,997 - DEBUG - ya.test - _save_outputs: Command (pid 3014170) oublock: 8
2025-10-31 15:39:47,998 - DEBUG - ya.test - _save_outputs: Command (pid 3014170) stime: 0.32448299999999997
2025-10-31 15:39:47,998 - DEBUG - ya.test - _save_outputs: Command (pid 3014170) utime: 0.120642
2025-10-31 15:39:48,006 - DEBUG - ya.test - _save_outputs: Command (pid 3014170) wtime: 0.567
2025-10-31 15:39:48,007 - DEBUG - ya.test - _save_outputs: Command (pid 3014170) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 4

2025-10-31 15:39:48,007 - DEBUG - ya.test - _save_outputs: Command (pid 3014170) errors:

2025-10-31 15:39:48,009 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/stm2/002faa/ydb/apps/ydbd/ydbd
2025-10-31 15:39:48,012 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/stm2/002faa/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:28790', '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:39:48,014 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-10-31 15:39:48,016 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-10-31 15:39:48,016 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/stm2/002faa/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:28790', '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:39:48,024 - DEBUG - ya.test - execute: Command pid: 3014687
2025-10-31 15:39:48,576 - DEBUG - ya.test - _save_outputs: Command (pid 3014687) rc: 0
2025-10-31 15:39:48,576 - DEBUG - ya.test - _save_outputs: Command (pid 3014687) elapsed time (sec): 0.5511689186096191
2025-10-31 15:39:48,577 - DEBUG - ya.test - _save_outputs: Command (pid 3014687) idrss: 0
2025-10-31 15:39:48,577 - DEBUG - ya.test - _save_outputs: Command (pid 3014687) inblock: 0
2025-10-31 15:39:48,577 - DEBUG - ya.test - _save_outputs: Command (pid 3014687) isrss: 0
2025-10-31 15:39:48,577 - DEBUG - ya.test - _save_outputs: Command (pid 3014687) ixrss: 0
2025-10-31 15:39:48,577 - DEBUG - ya.test - _save_outputs: Command (pid 3014687) majflt: 0
2025-10-31 15:39:48,578 - DEBUG - ya.test - _save_outputs: Command (pid 3014687) maxrss: 546828
2025-10-31 15:39:48,581 - DEBUG - ya.test - _save_outputs: Command (pid 3014687) minflt: 18274
2025-10-31 15:39:48,581 - DEBUG - ya.test - _save_outputs: Command (pid 3014687) msgrcv: 0
2025-10-31 15:39:48,581 - DEBUG - ya.test - _save_outputs: Command (pid 3014687) msgsnd: 0
2025-10-31 15:39:48,581 - DEBUG - ya.test - _save_outputs: Command (pid 3014687) nivcsw: 112
2025-10-31 15:39:48,582 - DEBUG - ya.test - _save_outputs: Command (pid 3014687) nsignals: 0
2025-10-31 15:39:48,582 - DEBUG - ya.test - _save_outputs: Command (pid 3014687) nswap: 0
2025-10-31 15:39:48,582 - DEBUG - ya.test - _save_outputs: Command (pid 3014687) nvcsw: 122
2025-10-31 15:39:48,582 - DEBUG - ya.test - _save_outputs: Command (pid 3014687) oublock: 8
2025-10-31 15:39:48,582 - DEBUG - ya.test - _save_outputs: Command (pid 3014687) stime: 0.33607899999999996
2025-10-31 15:39:48,582 - DEBUG - ya.test - _save_outputs: Command (pid 3014687) utime: 0.117673
2025-10-31 15:39:48,583 - DEBUG - ya.test - _save_outputs: Command (pid 3014687) wtime: 0.559
2025-10-31 15:39:48,583 - DEBUG - ya.test - _save_outputs: Command (pid 3014687) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-10-31 15:39:48,583 - DEBUG - ya.test - _save_outputs: Command (pid 3014687) errors:

2025-10-31 15:39:48,583 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-10-31 15:39:48,616 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-10-31 15:39:48,644 - 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:39:48,655 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 15:39:48,655 - 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:39:48,684 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-10-31 15:39:48,685 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 22bb2c08-cd3e-459c-9e4c-1488770db022, localhost:28790): creating call state
2025-10-31 15:39:48,685 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 22bb2c08-cd3e-459c-9e4c-1488770db022, localhost:28790): request = { database: "/Root" }
2025-10-31 15:39:48,701 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 22bb2c08-cd3e-459c-9e4c-1488770db022, localhost:28790): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-upzbhs6y6e.auto.internal" port: 28790 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:39:48,712 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-upzbhs6y6e.auto.internal:28790, location 1, ssl: False>]>
2025-10-31 15:39:48,716 - 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:39:48,744 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:28790
2025-10-31 15:39:48,749 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 0d42aee2-73c3-469c-8c78-ea85b483d5f3, ghrun-upzbhs6y6e.auto.internal:28790): creating call state
2025-10-31 15:39:48,749 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 0d42aee2-73c3-469c-8c78-ea85b483d5f3, ghrun-upzbhs6y6e.auto.internal:28790): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 15:39:48,757 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 0d42aee2-73c3-469c-8c78-ea85b483d5f3, ghrun-upzbhs6y6e.auto.internal:28790): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=YTVjY2IxNmUtZTAzNWQyMzEtMmZiZTRlMTYtOWUxY2RiNzA=" } } } }
2025-10-31 15:39:48,781 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_ydb_impex.py::TestImpex, test_name: test_multiple_files_and_stdin[tsv-additional_args2-column])
2025-10-31 15:39:48,782 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, fe0347f1-a17f-4a9d-8187-ac920fdfce2d, ghrun-upzbhs6y6e.auto.internal:28790): creating call state
2025-10-31 15:39:48,782 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, fe0347f1-a17f-4a9d-8187-ac920fdfce2d, ghrun-upzbhs6y6e.auto.internal:28790): request = { session_id: "ydb://session/3?node_id=1&id=YTVjY2IxNmUtZTAzNWQyMzEtMmZiZTRlMTYtOWUxY2RiNzA=" yql_text: "\n        CREATE TABLE `/Root/test_multiple_files_and_stdin[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 } } }
2025-10-31 15:39:49,243 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, fe0347f1-a17f-4a9d-8187-ac920fdfce2d, ghrun-upzbhs6y6e.auto.internal:28790): response = { operation { ready: true status: SUCCESS } }
2025-10-31 15:39:49,245 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/stm2/002faa/ydb/apps/ydb/ydb
2025-10-31 15:39:49,249 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out
2025-10-31 15:39:49,257 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err
2025-10-31 15:39:49,258 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/stm2/002faa/ydb/apps/ydb/ydb', '--endpoint', 'grpc://localhost:28790', '--database', '/Root', 'import', 'file', 'tsv', '-p', '/Root/test_multiple_files_and_stdin[tsv-additional_args2-column]', '--header', '/home/runner/.ya/build/build_root/stm2/002faa/tmp/test_multiple_files_and_stdin_0/tempinput0.tsv', '/home/runner/.ya/build/build_root/stm2/002faa/tmp/test_multiple_files_and_stdin_0/tempinput1.tsv', '/home/runner/.ya/build/build_root/stm2/002faa/tmp/test_multiple_files_and_stdin_0/tempinput2.tsv', '/home/runner/.ya/build/build_root/stm2/002faa/tmp/test_multiple_files_and_stdin_0/tempinput3.tsv']' in 'None' (waiting)
2025-10-31 15:39:49,262 - DEBUG - ya.test - execute: Command pid: 3015351
2025-10-31 15:39:49,450 - DEBUG - ya.test - _save_outputs: Command (pid 3015351) rc: 0
2025-10-31 15:39:49,450 - DEBUG - ya.test - _save_outputs: Command (pid 3015351) elapsed time (sec): 0.1867213249206543
2025-10-31 15:39:49,450 - DEBUG - ya.test - _save_outputs: Command (pid 3015351) idrss: 0
2025-10-31 15:39:49,451 - DEBUG - ya.test - _save_outputs: Command (pid 3015351) inblock: 0
2025-10-31 15:39:49,451 - DEBUG - ya.test - _save_outputs: Command (pid 3015351) isrss: 0
2025-10-31 15:39:49,451 - DEBUG - ya.test - _save_outputs: Command (pid 3015351) ixrss: 0
2025-10-31 15:39:49,451 - DEBUG - ya.test - _save_outputs: Command (pid 3015351) majflt: 0
2025-10-31 15:39:49,451 - DEBUG - ya.test - _save_outputs: Command (pid 3015351) maxrss: 184216
2025-10-31 15:39:49,451 - DEBUG - ya.test - _save_outputs: Command (pid 3015351) minflt: 4140
2025-10-31 15:39:49,452 - DEBUG - ya.test - _save_outputs: Command (pid 3015351) msgrcv: 0
2025-10-31 15:39:49,452 - DEBUG - ya.test - _save_outputs: Command (pid 3015351) msgsnd: 0
2025-10-31 15:39:49,452 - DEBUG - ya.test - _save_outputs: Command (pid 3015351) nivcsw: 51
2025-10-31 15:39:49,453 - DEBUG - ya.test - _save_outputs: Command (pid 3015351) nsignals: 0
2025-10-31 15:39:49,453 - DEBUG - ya.test - _save_outputs: Command (pid 3015351) nswap: 0
2025-10-31 15:39:49,453 - DEBUG - ya.test - _save_outputs: Command (pid 3015351) nvcsw: 510
2025-10-31 15:39:49,453 - DEBUG - ya.test - _save_outputs: Command (pid 3015351) oublock: 80
2025-10-31 15:39:49,453 - DEBUG - ya.test - _save_outputs: Command (pid 3015351) stime: 0.033873
2025-10-31 15:39:49,454 - DEBUG - ya.test - _save_outputs: Command (pid 3015351) utime: 0.060219999999999996
2025-10-31 15:39:49,454 - DEBUG - ya.test - _save_outputs: Command (pid 3015351) wtime: 0.191
2025-10-31 15:39:49,464 - DEBUG - ya.test - _save_outputs: Command (pid 3015351) output:

2025-10-31 15:39:49,464 - DEBUG - ya.test - _save_outputs: Command (pid 3015351) errors:
Elapsed: 0.0275 sec. Total read size: 290B. Average processing speed: 10.3KiB/s.


2025-10-31 15:39:49,465 - DEBUG - __tests__.test_ydb_impex - execute_ydb_cli_command: std_out:

2025-10-31 15:39:49,465 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/stm2/002faa/ydb/apps/ydb/ydb
2025-10-31 15:39:49,466 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.0
2025-10-31 15:39:49,466 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/stm2/002faa/ydb/apps/ydb/ydb', '--endpoint', 'grpc://localhost:28790', '--database', '/Root', 'table', 'query', 'execute', '-q', 'SELECT `key`, `id`, `value` FROM `/Root/test_multiple_files_and_stdin[tsv-additional_args2-column]` ORDER BY `key`', '-t', 'scan', '--format', 'tsv']' in 'None' (waiting)
2025-10-31 15:39:49,469 - DEBUG - ya.test - execute: Command pid: 3015577
2025-10-31 15:39:49,687 - DEBUG - ya.test - _save_outputs: Command (pid 3015577) rc: 0
2025-10-31 15:39:49,687 - DEBUG - ya.test - _save_outputs: Command (pid 3015577) elapsed time (sec): 0.21670293807983398
2025-10-31 15:39:49,687 - DEBUG - ya.test - _save_outputs: Command (pid 3015577) idrss: 0
2025-10-31 15:39:49,688 - DEBUG - ya.test - _save_outputs: Command (pid 3015577) inblock: 0
2025-10-31 15:39:49,688 - DEBUG - ya.test - _save_outputs: Command (pid 3015577) isrss: 0
2025-10-31 15:39:49,688 - DEBUG - ya.test - _save_outputs: Command (pid 3015577) ixrss: 0
2025-10-31 15:39:49,688 - DEBUG - ya.test - _save_outputs: Command (pid 3015577) majflt: 0
2025-10-31 15:39:49,688 - DEBUG - ya.test - _save_outputs: Command (pid 3015577) maxrss: 184216
2025-10-31 15:39:49,688 - DEBUG - ya.test - _save_outputs: Command (pid 3015577) minflt: 3435
2025-10-31 15:39:49,689 - DEBUG - ya.test - _save_outputs: Command (pid 3015577) msgrcv: 0
2025-10-31 15:39:49,689 - DEBUG - ya.test - _save_outputs: Command (pid 3015577) msgsnd: 0
2025-10-31 15:39:49,689 - DEBUG - ya.test - _save_outputs: Command (pid 3015577) nivcsw: 25
2025-10-31 15:39:49,690 - DEBUG - ya.test - _save_outputs: Command (pid 3015577) nsignals: 0
2025-10-31 15:39:49,692 - DEBUG - ya.test - _save_outputs: Command (pid 3015577) nswap: 0
2025-10-31 15:39:49,692 - DEBUG - ya.test - _save_outputs: Command (pid 3015577) nvcsw: 161
2025-10-31 15:39:49,693 - DEBUG - ya.test - _save_outputs: Command (pid 3015577) oublock: 8
2025-10-31 15:39:49,693 - DEBUG - ya.test - _save_outputs: Command (pid 3015577) stime: 0.013451999999999999
2025-10-31 15:39:49,693 - DEBUG - ya.test - _save_outputs: Command (pid 3015577) utime: 0.058293
2025-10-31 15:39:49,693 - DEBUG - ya.test - _save_outputs: Command (pid 3015577) wtime: 0.22
2025-10-31 15:39:49,693 - DEBUG - ya.test - _save_outputs: Command (pid 3015577) 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:39:49,693 - DEBUG - ya.test - _save_outputs: Command (pid 3015577) errors:

2025-10-31 15:39:49,694 - 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:39:49,695 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-10-31 15:40:13,822 - DEBUG - ya.test - _verify_test: Verifying [test_ydb_impex.TestImpex.test_multiple_files_and_stdin[tsv-additional_args2-column] in ydb/tests/functional/ydb_cli] canonical results
2025-10-31 15:40:13,827 - DEBUG - ya.test - verify: Test test_ydb_impex.TestImpex.test_multiple_files_and_stdin[tsv-additional_args2-column] status: good
