2025-11-01 04:19:56,583 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 04:19:56,583 - INFO - ya.test - pytest_runtest_setup: test_multiple_files_and_stdin[tsv-additional_args3-row]
2025-11-01 04:19:56,583 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 04:19:56,583 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-01 04:19:56,643 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004e0f/ydb/apps/ydbd/ydbd
2025-11-01 04:19:56,645 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/20432
2025-11-01 04:19:56,646 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/g81u/004e0f/r3tmp/kikimr_cluster_n9382ekk
2025-11-01 04:19:56,682 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004e0f/ydb/apps/ydbd/ydbd
2025-11-01 04:19:56,682 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/16748
2025-11-01 04:19:56,683 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/3502
2025-11-01 04:19:56,683 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/5824
2025-11-01 04:19:56,683 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/22598
2025-11-01 04:19:56,684 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/g81u/004e0f/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-11-01 04:19:56,684 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/g81u/004e0f/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/g81u/004e0f/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_drtiqdkr.log --grpc-port=16748 --mon-port=3502 --ic-port=20432
2025-11-01 04:19:56,684 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:16748/1, disk_size 68719476736
2025-11-01 04:19:56,684 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/g81u/004e0f/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-11-01 04:19:56,684 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/g81u/004e0f/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/g81u/004e0f/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_drtiqdkr.log --grpc-port=16748 --mon-port=3502 --ic-port=20432
2025-11-01 04:19:56,685 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/g81u/004e0f/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/g81u/004e0f/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/g81u/004e0f/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_drtiqdkr.log', '--grpc-port=16748', '--mon-port=3502', '--ic-port=20432')' in '/home/runner/.ya/build/build_root/g81u/004e0f/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-11-01 04:19:56,686 - DEBUG - ya.test - execute: Command pid: 2533013
2025-11-01 04:19:56,687 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:16748/1
2025-11-01 04:19:56,687 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-01 04:19:56,688 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-01 04:19:56,688 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004e0f/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 04:19:56,688 - DEBUG - ya.test - execute: Command pid: 2533014
2025-11-01 04:19:57,063 - DEBUG - ya.test - _save_outputs: Command (pid 2533014) rc: 0
2025-11-01 04:19:57,063 - DEBUG - ya.test - _save_outputs: Command (pid 2533014) elapsed time (sec): 0.3736913204193115
2025-11-01 04:19:57,063 - DEBUG - ya.test - _save_outputs: Command (pid 2533014) idrss: 0
2025-11-01 04:19:57,064 - DEBUG - ya.test - _save_outputs: Command (pid 2533014) inblock: 0
2025-11-01 04:19:57,064 - DEBUG - ya.test - _save_outputs: Command (pid 2533014) isrss: 0
2025-11-01 04:19:57,064 - DEBUG - ya.test - _save_outputs: Command (pid 2533014) ixrss: 0
2025-11-01 04:19:57,064 - DEBUG - ya.test - _save_outputs: Command (pid 2533014) majflt: 0
2025-11-01 04:19:57,064 - DEBUG - ya.test - _save_outputs: Command (pid 2533014) maxrss: 538372
2025-11-01 04:19:57,064 - DEBUG - ya.test - _save_outputs: Command (pid 2533014) minflt: 16127
2025-11-01 04:19:57,065 - DEBUG - ya.test - _save_outputs: Command (pid 2533014) msgrcv: 0
2025-11-01 04:19:57,065 - DEBUG - ya.test - _save_outputs: Command (pid 2533014) msgsnd: 0
2025-11-01 04:19:57,065 - DEBUG - ya.test - _save_outputs: Command (pid 2533014) nivcsw: 4
2025-11-01 04:19:57,065 - DEBUG - ya.test - _save_outputs: Command (pid 2533014) nsignals: 0
2025-11-01 04:19:57,065 - DEBUG - ya.test - _save_outputs: Command (pid 2533014) nswap: 0
2025-11-01 04:19:57,065 - DEBUG - ya.test - _save_outputs: Command (pid 2533014) nvcsw: 13
2025-11-01 04:19:57,065 - DEBUG - ya.test - _save_outputs: Command (pid 2533014) oublock: 8
2025-11-01 04:19:57,066 - DEBUG - ya.test - _save_outputs: Command (pid 2533014) stime: 0.21170899999999998
2025-11-01 04:19:57,066 - DEBUG - ya.test - _save_outputs: Command (pid 2533014) utime: 0.113701
2025-11-01 04:19:57,066 - DEBUG - ya.test - _save_outputs: Command (pid 2533014) wtime: 0.374
2025-11-01 04:19:57,066 - DEBUG - ya.test - _save_outputs: Command (pid 2533014) output:
Git info:
    Commit: 767d72532e5716ba790791cf237fdadb24b0e578
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 96af589a3c3d7740081955df0fe84da0a7b35651 into 2afee58ebdae8491f810ad53605d37376c4e5de6

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-i4gyxlpqdu
    Host information: 
        Linux ghrun-i4gyxlpqdu 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-11-01 04:19:57,066 - DEBUG - ya.test - _save_outputs: Command (pid 2533014) errors:

2025-11-01 04:19:57,067 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 767d72532e5716ba790791cf237fdadb24b0e578
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 96af589a3c3d7740081955df0fe84da0a7b35651 into 2afee58ebdae8491f810ad53605d37376c4e5de6
2025-11-01 04:19:58,891 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004e0f/ydb/apps/ydbd/ydbd
2025-11-01 04:19:58,892 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/g81u/004e0f/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:16748', '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: 20432\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-01 04:19:58,892 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-01 04:19:58,892 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-01 04:19:58,893 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004e0f/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:16748', '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: 20432\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-01 04:19:58,893 - DEBUG - ya.test - execute: Command pid: 2535212
2025-11-01 04:19:59,331 - DEBUG - ya.test - _save_outputs: Command (pid 2535212) rc: 0
2025-11-01 04:19:59,331 - DEBUG - ya.test - _save_outputs: Command (pid 2535212) elapsed time (sec): 0.4367704391479492
2025-11-01 04:19:59,331 - DEBUG - ya.test - _save_outputs: Command (pid 2535212) idrss: 0
2025-11-01 04:19:59,332 - DEBUG - ya.test - _save_outputs: Command (pid 2535212) inblock: 0
2025-11-01 04:19:59,332 - DEBUG - ya.test - _save_outputs: Command (pid 2535212) isrss: 0
2025-11-01 04:19:59,332 - DEBUG - ya.test - _save_outputs: Command (pid 2535212) ixrss: 0
2025-11-01 04:19:59,332 - DEBUG - ya.test - _save_outputs: Command (pid 2535212) majflt: 0
2025-11-01 04:19:59,332 - DEBUG - ya.test - _save_outputs: Command (pid 2535212) maxrss: 546816
2025-11-01 04:19:59,332 - DEBUG - ya.test - _save_outputs: Command (pid 2535212) minflt: 18270
2025-11-01 04:19:59,332 - DEBUG - ya.test - _save_outputs: Command (pid 2535212) msgrcv: 0
2025-11-01 04:19:59,333 - DEBUG - ya.test - _save_outputs: Command (pid 2535212) msgsnd: 0
2025-11-01 04:19:59,333 - DEBUG - ya.test - _save_outputs: Command (pid 2535212) nivcsw: 3
2025-11-01 04:19:59,333 - DEBUG - ya.test - _save_outputs: Command (pid 2535212) nsignals: 0
2025-11-01 04:19:59,333 - DEBUG - ya.test - _save_outputs: Command (pid 2535212) nswap: 0
2025-11-01 04:19:59,333 - DEBUG - ya.test - _save_outputs: Command (pid 2535212) nvcsw: 146
2025-11-01 04:19:59,333 - DEBUG - ya.test - _save_outputs: Command (pid 2535212) oublock: 8
2025-11-01 04:19:59,333 - DEBUG - ya.test - _save_outputs: Command (pid 2535212) stime: 0.2809
2025-11-01 04:19:59,334 - DEBUG - ya.test - _save_outputs: Command (pid 2535212) utime: 0.11262799999999999
2025-11-01 04:19:59,334 - DEBUG - ya.test - _save_outputs: Command (pid 2535212) wtime: 0.438
2025-11-01 04:19:59,334 - DEBUG - ya.test - _save_outputs: Command (pid 2535212) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 4

2025-11-01 04:19:59,334 - DEBUG - ya.test - _save_outputs: Command (pid 2535212) errors:

2025-11-01 04:19:59,335 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004e0f/ydb/apps/ydbd/ydbd
2025-11-01 04:19:59,335 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/g81u/004e0f/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:16748', '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-11-01 04:19:59,336 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-01 04:19:59,336 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-01 04:19:59,337 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004e0f/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:16748', '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-11-01 04:19:59,338 - DEBUG - ya.test - execute: Command pid: 2535559
2025-11-01 04:19:59,712 - DEBUG - ya.test - _save_outputs: Command (pid 2535559) rc: 0
2025-11-01 04:19:59,712 - DEBUG - ya.test - _save_outputs: Command (pid 2535559) elapsed time (sec): 0.3738675117492676
2025-11-01 04:19:59,712 - DEBUG - ya.test - _save_outputs: Command (pid 2535559) idrss: 0
2025-11-01 04:19:59,713 - DEBUG - ya.test - _save_outputs: Command (pid 2535559) inblock: 0
2025-11-01 04:19:59,713 - DEBUG - ya.test - _save_outputs: Command (pid 2535559) isrss: 0
2025-11-01 04:19:59,713 - DEBUG - ya.test - _save_outputs: Command (pid 2535559) ixrss: 0
2025-11-01 04:19:59,713 - DEBUG - ya.test - _save_outputs: Command (pid 2535559) majflt: 0
2025-11-01 04:19:59,713 - DEBUG - ya.test - _save_outputs: Command (pid 2535559) maxrss: 546840
2025-11-01 04:19:59,713 - DEBUG - ya.test - _save_outputs: Command (pid 2535559) minflt: 18270
2025-11-01 04:19:59,713 - DEBUG - ya.test - _save_outputs: Command (pid 2535559) msgrcv: 0
2025-11-01 04:19:59,713 - DEBUG - ya.test - _save_outputs: Command (pid 2535559) msgsnd: 0
2025-11-01 04:19:59,713 - DEBUG - ya.test - _save_outputs: Command (pid 2535559) nivcsw: 2
2025-11-01 04:19:59,713 - DEBUG - ya.test - _save_outputs: Command (pid 2535559) nsignals: 0
2025-11-01 04:19:59,714 - DEBUG - ya.test - _save_outputs: Command (pid 2535559) nswap: 0
2025-11-01 04:19:59,714 - DEBUG - ya.test - _save_outputs: Command (pid 2535559) nvcsw: 152
2025-11-01 04:19:59,714 - DEBUG - ya.test - _save_outputs: Command (pid 2535559) oublock: 8
2025-11-01 04:19:59,714 - DEBUG - ya.test - _save_outputs: Command (pid 2535559) stime: 0.208456
2025-11-01 04:19:59,714 - DEBUG - ya.test - _save_outputs: Command (pid 2535559) utime: 0.121927
2025-11-01 04:19:59,714 - DEBUG - ya.test - _save_outputs: Command (pid 2535559) wtime: 0.375
2025-11-01 04:19:59,714 - DEBUG - ya.test - _save_outputs: Command (pid 2535559) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-01 04:19:59,714 - DEBUG - ya.test - _save_outputs: Command (pid 2535559) errors:

2025-11-01 04:19:59,714 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-01 04:19:59,727 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-01 04:19:59,737 - 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-11-01 04:19:59,740 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 04:19:59,742 - 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-11-01 04:19:59,752 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-01 04:19:59,753 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 6a48287e-2af8-4948-8b99-33d63255bb92, localhost:16748): creating call state
2025-11-01 04:19:59,753 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 6a48287e-2af8-4948-8b99-33d63255bb92, localhost:16748): request = { database: "/Root" }
2025-11-01 04:19:59,756 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 6a48287e-2af8-4948-8b99-33d63255bb92, localhost:16748): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-i4gyxlpqdu.auto.internal" port: 16748 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-11-01 04:19:59,756 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-i4gyxlpqdu.auto.internal:16748, location 1, ssl: False>]>
2025-11-01 04:19:59,757 - 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-11-01 04:19:59,763 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:16748
2025-11-01 04:19:59,764 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 21d9cee5-5a59-4be4-8550-d9b251c52572, ghrun-i4gyxlpqdu.auto.internal:16748): creating call state
2025-11-01 04:19:59,765 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 21d9cee5-5a59-4be4-8550-d9b251c52572, ghrun-i4gyxlpqdu.auto.internal:16748): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:19:59,767 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 21d9cee5-5a59-4be4-8550-d9b251c52572, ghrun-i4gyxlpqdu.auto.internal:16748): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=ZTQyMjFmOGItZjI4Y2JlM2EtZGVmNGE1MzItYjk5ODhmM2Y=" } } } }
2025-11-01 04:19:59,770 - 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-11-01 04:19:59,771 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, 79d9f345-8565-42f0-901c-01d396f6fc3b, ghrun-i4gyxlpqdu.auto.internal:16748): creating call state
2025-11-01 04:19:59,771 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, 79d9f345-8565-42f0-901c-01d396f6fc3b, ghrun-i4gyxlpqdu.auto.internal:16748): request = { session_id: "ydb://session/3?node_id=1&id=ZTQyMjFmOGItZjI4Y2JlM2EtZGVmNGE1MzItYjk5ODhmM2Y=" 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-11-01 04:19:59,807 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, 79d9f345-8565-42f0-901c-01d396f6fc3b, ghrun-i4gyxlpqdu.auto.internal:16748): response = { operation { ready: true status: SUCCESS } }
2025-11-01 04:19:59,808 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004e0f/ydb/apps/ydb/ydb
2025-11-01 04:19:59,809 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out
2025-11-01 04:19:59,809 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err
2025-11-01 04:19:59,809 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004e0f/ydb/apps/ydb/ydb', '--endpoint', 'grpc://localhost:16748', '--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/g81u/004e0f/tmp/test_multiple_files_and_stdin_0/tempinput0.tsv', '/home/runner/.ya/build/build_root/g81u/004e0f/tmp/test_multiple_files_and_stdin_0/tempinput1.tsv', '/home/runner/.ya/build/build_root/g81u/004e0f/tmp/test_multiple_files_and_stdin_0/tempinput2.tsv', '/home/runner/.ya/build/build_root/g81u/004e0f/tmp/test_multiple_files_and_stdin_0/tempinput3.tsv']' in 'None' (waiting)
2025-11-01 04:19:59,810 - DEBUG - ya.test - execute: Command pid: 2535877
2025-11-01 04:19:59,956 - DEBUG - ya.test - _save_outputs: Command (pid 2535877) rc: 0
2025-11-01 04:19:59,956 - DEBUG - ya.test - _save_outputs: Command (pid 2535877) elapsed time (sec): 0.14478707313537598
2025-11-01 04:19:59,956 - DEBUG - ya.test - _save_outputs: Command (pid 2535877) idrss: 0
2025-11-01 04:19:59,957 - DEBUG - ya.test - _save_outputs: Command (pid 2535877) inblock: 0
2025-11-01 04:19:59,957 - DEBUG - ya.test - _save_outputs: Command (pid 2535877) isrss: 0
2025-11-01 04:19:59,957 - DEBUG - ya.test - _save_outputs: Command (pid 2535877) ixrss: 0
2025-11-01 04:19:59,957 - DEBUG - ya.test - _save_outputs: Command (pid 2535877) majflt: 0
2025-11-01 04:19:59,957 - DEBUG - ya.test - _save_outputs: Command (pid 2535877) maxrss: 184492
2025-11-01 04:19:59,958 - DEBUG - ya.test - _save_outputs: Command (pid 2535877) minflt: 4422
2025-11-01 04:19:59,958 - DEBUG - ya.test - _save_outputs: Command (pid 2535877) msgrcv: 0
2025-11-01 04:19:59,958 - DEBUG - ya.test - _save_outputs: Command (pid 2535877) msgsnd: 0
2025-11-01 04:19:59,958 - DEBUG - ya.test - _save_outputs: Command (pid 2535877) nivcsw: 4
2025-11-01 04:19:59,958 - DEBUG - ya.test - _save_outputs: Command (pid 2535877) nsignals: 0
2025-11-01 04:19:59,958 - DEBUG - ya.test - _save_outputs: Command (pid 2535877) nswap: 0
2025-11-01 04:19:59,959 - DEBUG - ya.test - _save_outputs: Command (pid 2535877) nvcsw: 919
2025-11-01 04:19:59,959 - DEBUG - ya.test - _save_outputs: Command (pid 2535877) oublock: 48
2025-11-01 04:19:59,959 - DEBUG - ya.test - _save_outputs: Command (pid 2535877) stime: 0.064819
2025-11-01 04:19:59,959 - DEBUG - ya.test - _save_outputs: Command (pid 2535877) utime: 0.027778999999999998
2025-11-01 04:19:59,959 - DEBUG - ya.test - _save_outputs: Command (pid 2535877) wtime: 0.146
2025-11-01 04:19:59,960 - DEBUG - ya.test - _save_outputs: Command (pid 2535877) output:

2025-11-01 04:19:59,960 - DEBUG - ya.test - _save_outputs: Command (pid 2535877) errors:
Elapsed: 0.00671 sec. Total read size: 290B. Average processing speed: 42.2KiB/s.


2025-11-01 04:19:59,960 - DEBUG - __tests__.test_ydb_impex - execute_ydb_cli_command: std_out:

2025-11-01 04:19:59,961 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004e0f/ydb/apps/ydb/ydb
2025-11-01 04:19:59,961 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.0
2025-11-01 04:19:59,962 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004e0f/ydb/apps/ydb/ydb', '--endpoint', 'grpc://localhost:16748', '--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-11-01 04:19:59,962 - DEBUG - ya.test - execute: Command pid: 2536169
2025-11-01 04:20:00,097 - DEBUG - ya.test - _save_outputs: Command (pid 2536169) rc: 0
2025-11-01 04:20:00,098 - DEBUG - ya.test - _save_outputs: Command (pid 2536169) elapsed time (sec): 0.1344001293182373
2025-11-01 04:20:00,098 - DEBUG - ya.test - _save_outputs: Command (pid 2536169) idrss: 0
2025-11-01 04:20:00,098 - DEBUG - ya.test - _save_outputs: Command (pid 2536169) inblock: 0
2025-11-01 04:20:00,098 - DEBUG - ya.test - _save_outputs: Command (pid 2536169) isrss: 0
2025-11-01 04:20:00,098 - DEBUG - ya.test - _save_outputs: Command (pid 2536169) ixrss: 0
2025-11-01 04:20:00,098 - DEBUG - ya.test - _save_outputs: Command (pid 2536169) majflt: 0
2025-11-01 04:20:00,099 - DEBUG - ya.test - _save_outputs: Command (pid 2536169) maxrss: 184492
2025-11-01 04:20:00,099 - DEBUG - ya.test - _save_outputs: Command (pid 2536169) minflt: 3443
2025-11-01 04:20:00,099 - DEBUG - ya.test - _save_outputs: Command (pid 2536169) msgrcv: 0
2025-11-01 04:20:00,099 - DEBUG - ya.test - _save_outputs: Command (pid 2536169) msgsnd: 0
2025-11-01 04:20:00,099 - DEBUG - ya.test - _save_outputs: Command (pid 2536169) nivcsw: 0
2025-11-01 04:20:00,099 - DEBUG - ya.test - _save_outputs: Command (pid 2536169) nsignals: 0
2025-11-01 04:20:00,100 - DEBUG - ya.test - _save_outputs: Command (pid 2536169) nswap: 0
2025-11-01 04:20:00,100 - DEBUG - ya.test - _save_outputs: Command (pid 2536169) nvcsw: 208
2025-11-01 04:20:00,100 - DEBUG - ya.test - _save_outputs: Command (pid 2536169) oublock: 8
2025-11-01 04:20:00,100 - DEBUG - ya.test - _save_outputs: Command (pid 2536169) stime: 0.015441
2025-11-01 04:20:00,100 - DEBUG - ya.test - _save_outputs: Command (pid 2536169) utime: 0.046325
2025-11-01 04:20:00,100 - DEBUG - ya.test - _save_outputs: Command (pid 2536169) wtime: 0.135
2025-11-01 04:20:00,101 - DEBUG - ya.test - _save_outputs: Command (pid 2536169) 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-11-01 04:20:00,101 - DEBUG - ya.test - _save_outputs: Command (pid 2536169) errors:

2025-11-01 04:20:00,101 - 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-11-01 04:20:00,103 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-11-01 04:20:23,552 - 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-11-01 04:20:23,556 - DEBUG - ya.test - verify: Test test_ydb_impex.TestImpex.test_multiple_files_and_stdin[tsv-additional_args3-row] status: good
