2025-11-01 04:20:48,184 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 04:20:48,184 - INFO - ya.test - pytest_runtest_setup: test_multiple_files_and_stdin[tsv-additional_args2-column]
2025-11-01 04:20:48,184 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 04:20:48,184 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-01 04:20:48,225 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004d96/ydb/apps/ydbd/ydbd
2025-11-01 04:20:48,226 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/28605
2025-11-01 04:20:48,227 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/g81u/004d96/r3tmp/kikimr_cluster_vzs3v3cp
2025-11-01 04:20:48,248 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004d96/ydb/apps/ydbd/ydbd
2025-11-01 04:20:48,249 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/11066
2025-11-01 04:20:48,249 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/7355
2025-11-01 04:20:48,249 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/16589
2025-11-01 04:20:48,250 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/17253
2025-11-01 04:20:48,250 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/g81u/004d96/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-11-01 04:20:48,250 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/g81u/004d96/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/004d96/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_eozp959v.log --grpc-port=11066 --mon-port=7355 --ic-port=28605
2025-11-01 04:20:48,250 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:11066/1, disk_size 68719476736
2025-11-01 04:20:48,251 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/g81u/004d96/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-11-01 04:20:48,251 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/g81u/004d96/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/004d96/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_eozp959v.log --grpc-port=11066 --mon-port=7355 --ic-port=28605
2025-11-01 04:20:48,251 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/g81u/004d96/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/g81u/004d96/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/g81u/004d96/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_eozp959v.log', '--grpc-port=11066', '--mon-port=7355', '--ic-port=28605')' in '/home/runner/.ya/build/build_root/g81u/004d96/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-11-01 04:20:48,252 - DEBUG - ya.test - execute: Command pid: 2577829
2025-11-01 04:20:48,253 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:11066/1
2025-11-01 04:20:48,253 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-01 04:20:48,254 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-01 04:20:48,254 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004d96/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 04:20:48,254 - DEBUG - ya.test - execute: Command pid: 2577830
2025-11-01 04:20:48,595 - DEBUG - ya.test - _save_outputs: Command (pid 2577830) rc: 0
2025-11-01 04:20:48,595 - DEBUG - ya.test - _save_outputs: Command (pid 2577830) elapsed time (sec): 0.3400695323944092
2025-11-01 04:20:48,596 - DEBUG - ya.test - _save_outputs: Command (pid 2577830) idrss: 0
2025-11-01 04:20:48,596 - DEBUG - ya.test - _save_outputs: Command (pid 2577830) inblock: 0
2025-11-01 04:20:48,596 - DEBUG - ya.test - _save_outputs: Command (pid 2577830) isrss: 0
2025-11-01 04:20:48,596 - DEBUG - ya.test - _save_outputs: Command (pid 2577830) ixrss: 0
2025-11-01 04:20:48,596 - DEBUG - ya.test - _save_outputs: Command (pid 2577830) majflt: 0
2025-11-01 04:20:48,596 - DEBUG - ya.test - _save_outputs: Command (pid 2577830) maxrss: 538372
2025-11-01 04:20:48,596 - DEBUG - ya.test - _save_outputs: Command (pid 2577830) minflt: 16127
2025-11-01 04:20:48,596 - DEBUG - ya.test - _save_outputs: Command (pid 2577830) msgrcv: 0
2025-11-01 04:20:48,597 - DEBUG - ya.test - _save_outputs: Command (pid 2577830) msgsnd: 0
2025-11-01 04:20:48,597 - DEBUG - ya.test - _save_outputs: Command (pid 2577830) nivcsw: 2
2025-11-01 04:20:48,597 - DEBUG - ya.test - _save_outputs: Command (pid 2577830) nsignals: 0
2025-11-01 04:20:48,597 - DEBUG - ya.test - _save_outputs: Command (pid 2577830) nswap: 0
2025-11-01 04:20:48,597 - DEBUG - ya.test - _save_outputs: Command (pid 2577830) nvcsw: 13
2025-11-01 04:20:48,597 - DEBUG - ya.test - _save_outputs: Command (pid 2577830) oublock: 8
2025-11-01 04:20:48,597 - DEBUG - ya.test - _save_outputs: Command (pid 2577830) stime: 0.202213
2025-11-01 04:20:48,597 - DEBUG - ya.test - _save_outputs: Command (pid 2577830) utime: 0.08970099999999999
2025-11-01 04:20:48,597 - DEBUG - ya.test - _save_outputs: Command (pid 2577830) wtime: 0.341
2025-11-01 04:20:48,597 - DEBUG - ya.test - _save_outputs: Command (pid 2577830) 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:20:48,598 - DEBUG - ya.test - _save_outputs: Command (pid 2577830) errors:

2025-11-01 04:20:48,598 - 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:20:50,336 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004d96/ydb/apps/ydbd/ydbd
2025-11-01 04:20:50,337 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/g81u/004d96/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:11066', '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: 28605\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-01 04:20:50,337 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-01 04:20:50,338 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-01 04:20:50,338 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004d96/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:11066', '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: 28605\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-01 04:20:50,339 - DEBUG - ya.test - execute: Command pid: 2578704
2025-11-01 04:20:51,007 - DEBUG - ya.test - _save_outputs: Command (pid 2578704) rc: 0
2025-11-01 04:20:51,007 - DEBUG - ya.test - _save_outputs: Command (pid 2578704) elapsed time (sec): 0.6673166751861572
2025-11-01 04:20:51,007 - DEBUG - ya.test - _save_outputs: Command (pid 2578704) idrss: 0
2025-11-01 04:20:51,007 - DEBUG - ya.test - _save_outputs: Command (pid 2578704) inblock: 0
2025-11-01 04:20:51,007 - DEBUG - ya.test - _save_outputs: Command (pid 2578704) isrss: 0
2025-11-01 04:20:51,007 - DEBUG - ya.test - _save_outputs: Command (pid 2578704) ixrss: 0
2025-11-01 04:20:51,008 - DEBUG - ya.test - _save_outputs: Command (pid 2578704) majflt: 0
2025-11-01 04:20:51,008 - DEBUG - ya.test - _save_outputs: Command (pid 2578704) maxrss: 546848
2025-11-01 04:20:51,008 - DEBUG - ya.test - _save_outputs: Command (pid 2578704) minflt: 18273
2025-11-01 04:20:51,008 - DEBUG - ya.test - _save_outputs: Command (pid 2578704) msgrcv: 0
2025-11-01 04:20:51,008 - DEBUG - ya.test - _save_outputs: Command (pid 2578704) msgsnd: 0
2025-11-01 04:20:51,008 - DEBUG - ya.test - _save_outputs: Command (pid 2578704) nivcsw: 1
2025-11-01 04:20:51,008 - DEBUG - ya.test - _save_outputs: Command (pid 2578704) nsignals: 0
2025-11-01 04:20:51,008 - DEBUG - ya.test - _save_outputs: Command (pid 2578704) nswap: 0
2025-11-01 04:20:51,008 - DEBUG - ya.test - _save_outputs: Command (pid 2578704) nvcsw: 136
2025-11-01 04:20:51,009 - DEBUG - ya.test - _save_outputs: Command (pid 2578704) oublock: 8
2025-11-01 04:20:51,009 - DEBUG - ya.test - _save_outputs: Command (pid 2578704) stime: 0.48571899999999996
2025-11-01 04:20:51,009 - DEBUG - ya.test - _save_outputs: Command (pid 2578704) utime: 0.138901
2025-11-01 04:20:51,009 - DEBUG - ya.test - _save_outputs: Command (pid 2578704) wtime: 0.668
2025-11-01 04:20:51,009 - DEBUG - ya.test - _save_outputs: Command (pid 2578704) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 4

2025-11-01 04:20:51,009 - DEBUG - ya.test - _save_outputs: Command (pid 2578704) errors:

2025-11-01 04:20:51,010 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004d96/ydb/apps/ydbd/ydbd
2025-11-01 04:20:51,010 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/g81u/004d96/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:11066', '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:20:51,011 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-01 04:20:51,011 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-01 04:20:51,011 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004d96/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:11066', '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:20:51,012 - DEBUG - ya.test - execute: Command pid: 2579256
2025-11-01 04:20:51,771 - DEBUG - ya.test - _save_outputs: Command (pid 2579256) rc: 0
2025-11-01 04:20:51,772 - DEBUG - ya.test - _save_outputs: Command (pid 2579256) elapsed time (sec): 0.7587289810180664
2025-11-01 04:20:51,772 - DEBUG - ya.test - _save_outputs: Command (pid 2579256) idrss: 0
2025-11-01 04:20:51,772 - DEBUG - ya.test - _save_outputs: Command (pid 2579256) inblock: 0
2025-11-01 04:20:51,772 - DEBUG - ya.test - _save_outputs: Command (pid 2579256) isrss: 0
2025-11-01 04:20:51,772 - DEBUG - ya.test - _save_outputs: Command (pid 2579256) ixrss: 0
2025-11-01 04:20:51,773 - DEBUG - ya.test - _save_outputs: Command (pid 2579256) majflt: 0
2025-11-01 04:20:51,773 - DEBUG - ya.test - _save_outputs: Command (pid 2579256) maxrss: 546816
2025-11-01 04:20:51,773 - DEBUG - ya.test - _save_outputs: Command (pid 2579256) minflt: 18272
2025-11-01 04:20:51,773 - DEBUG - ya.test - _save_outputs: Command (pid 2579256) msgrcv: 0
2025-11-01 04:20:51,773 - DEBUG - ya.test - _save_outputs: Command (pid 2579256) msgsnd: 0
2025-11-01 04:20:51,773 - DEBUG - ya.test - _save_outputs: Command (pid 2579256) nivcsw: 4
2025-11-01 04:20:51,773 - DEBUG - ya.test - _save_outputs: Command (pid 2579256) nsignals: 0
2025-11-01 04:20:51,773 - DEBUG - ya.test - _save_outputs: Command (pid 2579256) nswap: 0
2025-11-01 04:20:51,773 - DEBUG - ya.test - _save_outputs: Command (pid 2579256) nvcsw: 149
2025-11-01 04:20:51,773 - DEBUG - ya.test - _save_outputs: Command (pid 2579256) oublock: 8
2025-11-01 04:20:51,774 - DEBUG - ya.test - _save_outputs: Command (pid 2579256) stime: 0.6229779999999999
2025-11-01 04:20:51,774 - DEBUG - ya.test - _save_outputs: Command (pid 2579256) utime: 0.093259
2025-11-01 04:20:51,774 - DEBUG - ya.test - _save_outputs: Command (pid 2579256) wtime: 0.76
2025-11-01 04:20:51,774 - DEBUG - ya.test - _save_outputs: Command (pid 2579256) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-01 04:20:51,774 - DEBUG - ya.test - _save_outputs: Command (pid 2579256) errors:

2025-11-01 04:20:51,774 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-01 04:20:51,786 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-01 04:20:51,794 - 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:20:51,796 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 04:20:51,797 - 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:20:51,805 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-01 04:20:51,805 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 54a72804-df7f-4858-899f-60f75edde0d5, localhost:11066): creating call state
2025-11-01 04:20:51,806 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 54a72804-df7f-4858-899f-60f75edde0d5, localhost:11066): request = { database: "/Root" }
2025-11-01 04:20:51,808 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 54a72804-df7f-4858-899f-60f75edde0d5, localhost:11066): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-i4gyxlpqdu.auto.internal" port: 11066 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:20:51,809 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-i4gyxlpqdu.auto.internal:11066, location 1, ssl: False>]>
2025-11-01 04:20:51,809 - 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:20:51,815 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:11066
2025-11-01 04:20:51,816 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 31433708-27da-4c9d-9695-5bc1c44758da, ghrun-i4gyxlpqdu.auto.internal:11066): creating call state
2025-11-01 04:20:51,817 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 31433708-27da-4c9d-9695-5bc1c44758da, ghrun-i4gyxlpqdu.auto.internal:11066): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:20:51,819 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 31433708-27da-4c9d-9695-5bc1c44758da, ghrun-i4gyxlpqdu.auto.internal:11066): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=ZmVjMWQ2NDctZjdjNDE1NWItMWEzZjBkMjEtNTEzZDZmY2E=" } } } }
2025-11-01 04:20:51,821 - 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-11-01 04:20:51,822 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, 09834830-839b-4bf2-8ff5-6f2b0583da87, ghrun-i4gyxlpqdu.auto.internal:11066): creating call state
2025-11-01 04:20:51,822 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, 09834830-839b-4bf2-8ff5-6f2b0583da87, ghrun-i4gyxlpqdu.auto.internal:11066): request = { session_id: "ydb://session/3?node_id=1&id=ZmVjMWQ2NDctZjdjNDE1NWItMWEzZjBkMjEtNTEzZDZmY2E=" 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-11-01 04:20:52,081 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, 09834830-839b-4bf2-8ff5-6f2b0583da87, ghrun-i4gyxlpqdu.auto.internal:11066): response = { operation { ready: true status: SUCCESS } }
2025-11-01 04:20:52,083 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004d96/ydb/apps/ydb/ydb
2025-11-01 04:20:52,084 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out
2025-11-01 04:20:52,084 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err
2025-11-01 04:20:52,084 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004d96/ydb/apps/ydb/ydb', '--endpoint', 'grpc://localhost:11066', '--database', '/Root', 'import', 'file', 'tsv', '-p', '/Root/test_multiple_files_and_stdin[tsv-additional_args2-column]', '--header', '/home/runner/.ya/build/build_root/g81u/004d96/tmp/test_multiple_files_and_stdin_0/tempinput0.tsv', '/home/runner/.ya/build/build_root/g81u/004d96/tmp/test_multiple_files_and_stdin_0/tempinput1.tsv', '/home/runner/.ya/build/build_root/g81u/004d96/tmp/test_multiple_files_and_stdin_0/tempinput2.tsv', '/home/runner/.ya/build/build_root/g81u/004d96/tmp/test_multiple_files_and_stdin_0/tempinput3.tsv']' in 'None' (waiting)
2025-11-01 04:20:52,085 - DEBUG - ya.test - execute: Command pid: 2580543
2025-11-01 04:20:52,229 - DEBUG - ya.test - _save_outputs: Command (pid 2580543) rc: 0
2025-11-01 04:20:52,229 - DEBUG - ya.test - _save_outputs: Command (pid 2580543) elapsed time (sec): 0.1434485912322998
2025-11-01 04:20:52,229 - DEBUG - ya.test - _save_outputs: Command (pid 2580543) idrss: 0
2025-11-01 04:20:52,229 - DEBUG - ya.test - _save_outputs: Command (pid 2580543) inblock: 0
2025-11-01 04:20:52,229 - DEBUG - ya.test - _save_outputs: Command (pid 2580543) isrss: 0
2025-11-01 04:20:52,230 - DEBUG - ya.test - _save_outputs: Command (pid 2580543) ixrss: 0
2025-11-01 04:20:52,230 - DEBUG - ya.test - _save_outputs: Command (pid 2580543) majflt: 0
2025-11-01 04:20:52,230 - DEBUG - ya.test - _save_outputs: Command (pid 2580543) maxrss: 184488
2025-11-01 04:20:52,230 - DEBUG - ya.test - _save_outputs: Command (pid 2580543) minflt: 4164
2025-11-01 04:20:52,230 - DEBUG - ya.test - _save_outputs: Command (pid 2580543) msgrcv: 0
2025-11-01 04:20:52,230 - DEBUG - ya.test - _save_outputs: Command (pid 2580543) msgsnd: 0
2025-11-01 04:20:52,230 - DEBUG - ya.test - _save_outputs: Command (pid 2580543) nivcsw: 0
2025-11-01 04:20:52,230 - DEBUG - ya.test - _save_outputs: Command (pid 2580543) nsignals: 0
2025-11-01 04:20:52,230 - DEBUG - ya.test - _save_outputs: Command (pid 2580543) nswap: 0
2025-11-01 04:20:52,231 - DEBUG - ya.test - _save_outputs: Command (pid 2580543) nvcsw: 552
2025-11-01 04:20:52,231 - DEBUG - ya.test - _save_outputs: Command (pid 2580543) oublock: 80
2025-11-01 04:20:52,231 - DEBUG - ya.test - _save_outputs: Command (pid 2580543) stime: 0.034811999999999996
2025-11-01 04:20:52,231 - DEBUG - ya.test - _save_outputs: Command (pid 2580543) utime: 0.052218
2025-11-01 04:20:52,231 - DEBUG - ya.test - _save_outputs: Command (pid 2580543) wtime: 0.144
2025-11-01 04:20:52,231 - DEBUG - ya.test - _save_outputs: Command (pid 2580543) output:

2025-11-01 04:20:52,231 - DEBUG - ya.test - _save_outputs: Command (pid 2580543) errors:
Elapsed: 0.0156 sec. Total read size: 290B. Average processing speed: 18.1KiB/s.


2025-11-01 04:20:52,231 - DEBUG - __tests__.test_ydb_impex - execute_ydb_cli_command: std_out:

2025-11-01 04:20:52,232 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004d96/ydb/apps/ydb/ydb
2025-11-01 04:20:52,232 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.0
2025-11-01 04:20:52,232 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004d96/ydb/apps/ydb/ydb', '--endpoint', 'grpc://localhost:11066', '--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-11-01 04:20:52,233 - DEBUG - ya.test - execute: Command pid: 2581033
2025-11-01 04:20:52,414 - DEBUG - ya.test - _save_outputs: Command (pid 2581033) rc: 0
2025-11-01 04:20:52,415 - DEBUG - ya.test - _save_outputs: Command (pid 2581033) elapsed time (sec): 0.18070507049560547
2025-11-01 04:20:52,415 - DEBUG - ya.test - _save_outputs: Command (pid 2581033) idrss: 0
2025-11-01 04:20:52,415 - DEBUG - ya.test - _save_outputs: Command (pid 2581033) inblock: 0
2025-11-01 04:20:52,415 - DEBUG - ya.test - _save_outputs: Command (pid 2581033) isrss: 0
2025-11-01 04:20:52,415 - DEBUG - ya.test - _save_outputs: Command (pid 2581033) ixrss: 0
2025-11-01 04:20:52,415 - DEBUG - ya.test - _save_outputs: Command (pid 2581033) majflt: 2
2025-11-01 04:20:52,415 - DEBUG - ya.test - _save_outputs: Command (pid 2581033) maxrss: 184488
2025-11-01 04:20:52,415 - DEBUG - ya.test - _save_outputs: Command (pid 2581033) minflt: 3562
2025-11-01 04:20:52,415 - DEBUG - ya.test - _save_outputs: Command (pid 2581033) msgrcv: 0
2025-11-01 04:20:52,416 - DEBUG - ya.test - _save_outputs: Command (pid 2581033) msgsnd: 0
2025-11-01 04:20:52,416 - DEBUG - ya.test - _save_outputs: Command (pid 2581033) nivcsw: 0
2025-11-01 04:20:52,416 - DEBUG - ya.test - _save_outputs: Command (pid 2581033) nsignals: 0
2025-11-01 04:20:52,416 - DEBUG - ya.test - _save_outputs: Command (pid 2581033) nswap: 0
2025-11-01 04:20:52,416 - DEBUG - ya.test - _save_outputs: Command (pid 2581033) nvcsw: 211
2025-11-01 04:20:52,416 - DEBUG - ya.test - _save_outputs: Command (pid 2581033) oublock: 8
2025-11-01 04:20:52,416 - DEBUG - ya.test - _save_outputs: Command (pid 2581033) stime: 0.030029999999999998
2025-11-01 04:20:52,416 - DEBUG - ya.test - _save_outputs: Command (pid 2581033) utime: 0.031819
2025-11-01 04:20:52,416 - DEBUG - ya.test - _save_outputs: Command (pid 2581033) wtime: 0.182
2025-11-01 04:20:52,417 - DEBUG - ya.test - _save_outputs: Command (pid 2581033) 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:52,417 - DEBUG - ya.test - _save_outputs: Command (pid 2581033) errors:

2025-11-01 04:20:52,417 - 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:52,418 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-11-01 04:21:15,816 - 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-11-01 04:21:15,822 - DEBUG - ya.test - verify: Test test_ydb_impex.TestImpex.test_multiple_files_and_stdin[tsv-additional_args2-column] status: good
