2025-10-31 08:41:35,249 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-31 08:41:35,249 - INFO - ya.test - pytest_runtest_setup: test_multiple_files_and_stdin[tsv-additional_args2-column]
2025-10-31 08:41:35,249 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-31 08:41:35,249 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-31 08:41:35,316 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001e92/ydb/apps/ydbd/ydbd
2025-10-31 08:41:35,317 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/1392
2025-10-31 08:41:35,318 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/1393
2025-10-31 08:41:35,319 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/pogg/001e92/r3tmp/kikimr_cluster_s4uz79ht
2025-10-31 08:41:35,354 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001e92/ydb/apps/ydbd/ydbd
2025-10-31 08:41:35,354 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/5802
2025-10-31 08:41:35,355 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/28055
2025-10-31 08:41:35,356 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18245
2025-10-31 08:41:35,357 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/19578
2025-10-31 08:41:35,358 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/pogg/001e92/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 08:41:35,358 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/pogg/001e92/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/pogg/001e92/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_yaxohoj6.log --grpc-port=5802 --mon-port=28055 --ic-port=1393
2025-10-31 08:41:35,358 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:5802/1, disk_size 68719476736
2025-10-31 08:41:35,358 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/pogg/001e92/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 08:41:35,359 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/pogg/001e92/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/pogg/001e92/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_yaxohoj6.log --grpc-port=5802 --mon-port=28055 --ic-port=1393
2025-10-31 08:41:35,359 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/pogg/001e92/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/pogg/001e92/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/pogg/001e92/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_yaxohoj6.log', '--grpc-port=5802', '--mon-port=28055', '--ic-port=1393')' in '/home/runner/.ya/build/build_root/pogg/001e92/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 08:41:35,361 - DEBUG - ya.test - execute: Command pid: 3240573
2025-10-31 08:41:35,363 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:5802/1
2025-10-31 08:41:35,364 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-10-31 08:41:35,365 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-10-31 08:41:35,365 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001e92/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-31 08:41:35,366 - DEBUG - ya.test - execute: Command pid: 3240580
2025-10-31 08:41:35,846 - DEBUG - ya.test - _save_outputs: Command (pid 3240580) rc: 0
2025-10-31 08:41:35,847 - DEBUG - ya.test - _save_outputs: Command (pid 3240580) elapsed time (sec): 0.47977352142333984
2025-10-31 08:41:35,847 - DEBUG - ya.test - _save_outputs: Command (pid 3240580) idrss: 0
2025-10-31 08:41:35,847 - DEBUG - ya.test - _save_outputs: Command (pid 3240580) inblock: 0
2025-10-31 08:41:35,847 - DEBUG - ya.test - _save_outputs: Command (pid 3240580) isrss: 0
2025-10-31 08:41:35,847 - DEBUG - ya.test - _save_outputs: Command (pid 3240580) ixrss: 0
2025-10-31 08:41:35,847 - DEBUG - ya.test - _save_outputs: Command (pid 3240580) majflt: 0
2025-10-31 08:41:35,848 - DEBUG - ya.test - _save_outputs: Command (pid 3240580) maxrss: 538184
2025-10-31 08:41:35,848 - DEBUG - ya.test - _save_outputs: Command (pid 3240580) minflt: 16129
2025-10-31 08:41:35,848 - DEBUG - ya.test - _save_outputs: Command (pid 3240580) msgrcv: 0
2025-10-31 08:41:35,848 - DEBUG - ya.test - _save_outputs: Command (pid 3240580) msgsnd: 0
2025-10-31 08:41:35,848 - DEBUG - ya.test - _save_outputs: Command (pid 3240580) nivcsw: 27
2025-10-31 08:41:35,849 - DEBUG - ya.test - _save_outputs: Command (pid 3240580) nsignals: 0
2025-10-31 08:41:35,849 - DEBUG - ya.test - _save_outputs: Command (pid 3240580) nswap: 0
2025-10-31 08:41:35,849 - DEBUG - ya.test - _save_outputs: Command (pid 3240580) nvcsw: 15
2025-10-31 08:41:35,849 - DEBUG - ya.test - _save_outputs: Command (pid 3240580) oublock: 8
2025-10-31 08:41:35,850 - DEBUG - ya.test - _save_outputs: Command (pid 3240580) stime: 0.270068
2025-10-31 08:41:35,850 - DEBUG - ya.test - _save_outputs: Command (pid 3240580) utime: 0.133333
2025-10-31 08:41:35,851 - DEBUG - ya.test - _save_outputs: Command (pid 3240580) wtime: 0.481
2025-10-31 08:41:35,852 - DEBUG - ya.test - _save_outputs: Command (pid 3240580) output:
Git info:
    Commit: 82bf8aab4f547668632ff26479ecdb9996428c61
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 43cd17c8a58e28cd156b58873e20cf204c35cf0d into e300863ab69d6519229a61bcfeb54a36b8d86bd0

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-uabpkrvm6i
    Host information: 
        Linux ghrun-uabpkrvm6i 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 08:41:35,852 - DEBUG - ya.test - _save_outputs: Command (pid 3240580) errors:

2025-10-31 08:41:35,853 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 82bf8aab4f547668632ff26479ecdb9996428c61
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 43cd17c8a58e28cd156b58873e20cf204c35cf0d into e300863ab69d6519229a61bcfeb54a36b8d86bd0
2025-10-31 08:41:37,805 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001e92/ydb/apps/ydbd/ydbd
2025-10-31 08:41:37,806 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/pogg/001e92/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:5802', '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: 1393\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-10-31 08:41:37,807 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-10-31 08:41:37,808 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-10-31 08:41:37,809 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001e92/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:5802', '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: 1393\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-10-31 08:41:37,810 - DEBUG - ya.test - execute: Command pid: 3242198
2025-10-31 08:41:38,316 - DEBUG - ya.test - _save_outputs: Command (pid 3242198) rc: 0
2025-10-31 08:41:38,316 - DEBUG - ya.test - _save_outputs: Command (pid 3242198) elapsed time (sec): 0.5029282569885254
2025-10-31 08:41:38,317 - DEBUG - ya.test - _save_outputs: Command (pid 3242198) idrss: 0
2025-10-31 08:41:38,317 - DEBUG - ya.test - _save_outputs: Command (pid 3242198) inblock: 0
2025-10-31 08:41:38,317 - DEBUG - ya.test - _save_outputs: Command (pid 3242198) isrss: 0
2025-10-31 08:41:38,317 - DEBUG - ya.test - _save_outputs: Command (pid 3242198) ixrss: 0
2025-10-31 08:41:38,317 - DEBUG - ya.test - _save_outputs: Command (pid 3242198) majflt: 0
2025-10-31 08:41:38,318 - DEBUG - ya.test - _save_outputs: Command (pid 3242198) maxrss: 546656
2025-10-31 08:41:38,318 - DEBUG - ya.test - _save_outputs: Command (pid 3242198) minflt: 18271
2025-10-31 08:41:38,318 - DEBUG - ya.test - _save_outputs: Command (pid 3242198) msgrcv: 0
2025-10-31 08:41:38,318 - DEBUG - ya.test - _save_outputs: Command (pid 3242198) msgsnd: 0
2025-10-31 08:41:38,318 - DEBUG - ya.test - _save_outputs: Command (pid 3242198) nivcsw: 53
2025-10-31 08:41:38,319 - DEBUG - ya.test - _save_outputs: Command (pid 3242198) nsignals: 0
2025-10-31 08:41:38,319 - DEBUG - ya.test - _save_outputs: Command (pid 3242198) nswap: 0
2025-10-31 08:41:38,319 - DEBUG - ya.test - _save_outputs: Command (pid 3242198) nvcsw: 145
2025-10-31 08:41:38,319 - DEBUG - ya.test - _save_outputs: Command (pid 3242198) oublock: 8
2025-10-31 08:41:38,319 - DEBUG - ya.test - _save_outputs: Command (pid 3242198) stime: 0.281285
2025-10-31 08:41:38,320 - DEBUG - ya.test - _save_outputs: Command (pid 3242198) utime: 0.16364599999999999
2025-10-31 08:41:38,320 - DEBUG - ya.test - _save_outputs: Command (pid 3242198) wtime: 0.504
2025-10-31 08:41:38,320 - DEBUG - ya.test - _save_outputs: Command (pid 3242198) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 4

2025-10-31 08:41:38,320 - DEBUG - ya.test - _save_outputs: Command (pid 3242198) errors:

2025-10-31 08:41:38,321 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001e92/ydb/apps/ydbd/ydbd
2025-10-31 08:41:38,322 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/pogg/001e92/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:5802', '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 08:41:38,323 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-10-31 08:41:38,323 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-10-31 08:41:38,323 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001e92/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:5802', '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 08:41:38,325 - DEBUG - ya.test - execute: Command pid: 3242757
2025-10-31 08:41:38,803 - DEBUG - ya.test - _save_outputs: Command (pid 3242757) rc: 0
2025-10-31 08:41:38,804 - DEBUG - ya.test - _save_outputs: Command (pid 3242757) elapsed time (sec): 0.47770094871520996
2025-10-31 08:41:38,804 - DEBUG - ya.test - _save_outputs: Command (pid 3242757) idrss: 0
2025-10-31 08:41:38,804 - DEBUG - ya.test - _save_outputs: Command (pid 3242757) inblock: 0
2025-10-31 08:41:38,804 - DEBUG - ya.test - _save_outputs: Command (pid 3242757) isrss: 0
2025-10-31 08:41:38,804 - DEBUG - ya.test - _save_outputs: Command (pid 3242757) ixrss: 0
2025-10-31 08:41:38,805 - DEBUG - ya.test - _save_outputs: Command (pid 3242757) majflt: 0
2025-10-31 08:41:38,805 - DEBUG - ya.test - _save_outputs: Command (pid 3242757) maxrss: 546672
2025-10-31 08:41:38,805 - DEBUG - ya.test - _save_outputs: Command (pid 3242757) minflt: 18267
2025-10-31 08:41:38,805 - DEBUG - ya.test - _save_outputs: Command (pid 3242757) msgrcv: 0
2025-10-31 08:41:38,805 - DEBUG - ya.test - _save_outputs: Command (pid 3242757) msgsnd: 0
2025-10-31 08:41:38,806 - DEBUG - ya.test - _save_outputs: Command (pid 3242757) nivcsw: 23
2025-10-31 08:41:38,806 - DEBUG - ya.test - _save_outputs: Command (pid 3242757) nsignals: 0
2025-10-31 08:41:38,806 - DEBUG - ya.test - _save_outputs: Command (pid 3242757) nswap: 0
2025-10-31 08:41:38,806 - DEBUG - ya.test - _save_outputs: Command (pid 3242757) nvcsw: 128
2025-10-31 08:41:38,806 - DEBUG - ya.test - _save_outputs: Command (pid 3242757) oublock: 8
2025-10-31 08:41:38,806 - DEBUG - ya.test - _save_outputs: Command (pid 3242757) stime: 0.300807
2025-10-31 08:41:38,807 - DEBUG - ya.test - _save_outputs: Command (pid 3242757) utime: 0.132355
2025-10-31 08:41:38,807 - DEBUG - ya.test - _save_outputs: Command (pid 3242757) wtime: 0.479
2025-10-31 08:41:38,807 - DEBUG - ya.test - _save_outputs: Command (pid 3242757) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-10-31 08:41:38,807 - DEBUG - ya.test - _save_outputs: Command (pid 3242757) errors:

2025-10-31 08:41:38,808 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-10-31 08:41:38,826 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-10-31 08:41:38,838 - 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 08:41:38,841 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:41:38,847 - 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 08:41:38,861 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-10-31 08:41:38,861 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 245d1753-4f00-4bba-8af5-0a3274ffe314, localhost:5802): creating call state
2025-10-31 08:41:38,864 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 245d1753-4f00-4bba-8af5-0a3274ffe314, localhost:5802): request = { database: "/Root" }
2025-10-31 08:41:38,867 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 245d1753-4f00-4bba-8af5-0a3274ffe314, localhost:5802): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-uabpkrvm6i.auto.internal" port: 5802 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 08:41:38,868 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-uabpkrvm6i.auto.internal:5802, location 1, ssl: False>]>
2025-10-31 08:41:38,868 - 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 08:41:38,877 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:5802
2025-10-31 08:41:38,879 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 12e35972-3b49-4582-bdd6-8f2704e37615, ghrun-uabpkrvm6i.auto.internal:5802): creating call state
2025-10-31 08:41:38,880 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 12e35972-3b49-4582-bdd6-8f2704e37615, ghrun-uabpkrvm6i.auto.internal:5802): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:41:38,883 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 12e35972-3b49-4582-bdd6-8f2704e37615, ghrun-uabpkrvm6i.auto.internal:5802): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=YmU0NjQ5M2QtNGIzMzhiNTYtZDdlYTVlYTctOTMwNDUzYg==" } } } }
2025-10-31 08:41:38,887 - 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 08:41:38,887 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, f46c098d-0f58-48da-8e7c-526c767e3e19, ghrun-uabpkrvm6i.auto.internal:5802): creating call state
2025-10-31 08:41:38,889 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, f46c098d-0f58-48da-8e7c-526c767e3e19, ghrun-uabpkrvm6i.auto.internal:5802): request = { session_id: "ydb://session/3?node_id=1&id=YmU0NjQ5M2QtNGIzMzhiNTYtZDdlYTVlYTctOTMwNDUzYg==" 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 08:41:39,226 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, f46c098d-0f58-48da-8e7c-526c767e3e19, ghrun-uabpkrvm6i.auto.internal:5802): response = { operation { ready: true status: SUCCESS } }
2025-10-31 08:41:39,228 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001e92/ydb/apps/ydb/ydb
2025-10-31 08:41:39,230 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out
2025-10-31 08:41:39,231 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err
2025-10-31 08:41:39,231 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001e92/ydb/apps/ydb/ydb', '--endpoint', 'grpc://localhost:5802', '--database', '/Root', 'import', 'file', 'tsv', '-p', '/Root/test_multiple_files_and_stdin[tsv-additional_args2-column]', '--header', '/home/runner/.ya/build/build_root/pogg/001e92/tmp/test_multiple_files_and_stdin_0/tempinput0.tsv', '/home/runner/.ya/build/build_root/pogg/001e92/tmp/test_multiple_files_and_stdin_0/tempinput1.tsv', '/home/runner/.ya/build/build_root/pogg/001e92/tmp/test_multiple_files_and_stdin_0/tempinput2.tsv', '/home/runner/.ya/build/build_root/pogg/001e92/tmp/test_multiple_files_and_stdin_0/tempinput3.tsv']' in 'None' (waiting)
2025-10-31 08:41:39,232 - DEBUG - ya.test - execute: Command pid: 3243257
2025-10-31 08:41:39,401 - DEBUG - ya.test - _save_outputs: Command (pid 3243257) rc: 0
2025-10-31 08:41:39,402 - DEBUG - ya.test - _save_outputs: Command (pid 3243257) elapsed time (sec): 0.1680154800415039
2025-10-31 08:41:39,402 - DEBUG - ya.test - _save_outputs: Command (pid 3243257) idrss: 0
2025-10-31 08:41:39,402 - DEBUG - ya.test - _save_outputs: Command (pid 3243257) inblock: 0
2025-10-31 08:41:39,402 - DEBUG - ya.test - _save_outputs: Command (pid 3243257) isrss: 0
2025-10-31 08:41:39,402 - DEBUG - ya.test - _save_outputs: Command (pid 3243257) ixrss: 0
2025-10-31 08:41:39,403 - DEBUG - ya.test - _save_outputs: Command (pid 3243257) majflt: 0
2025-10-31 08:41:39,403 - DEBUG - ya.test - _save_outputs: Command (pid 3243257) maxrss: 184408
2025-10-31 08:41:39,403 - DEBUG - ya.test - _save_outputs: Command (pid 3243257) minflt: 4156
2025-10-31 08:41:39,403 - DEBUG - ya.test - _save_outputs: Command (pid 3243257) msgrcv: 0
2025-10-31 08:41:39,403 - DEBUG - ya.test - _save_outputs: Command (pid 3243257) msgsnd: 0
2025-10-31 08:41:39,403 - DEBUG - ya.test - _save_outputs: Command (pid 3243257) nivcsw: 10
2025-10-31 08:41:39,404 - DEBUG - ya.test - _save_outputs: Command (pid 3243257) nsignals: 0
2025-10-31 08:41:39,404 - DEBUG - ya.test - _save_outputs: Command (pid 3243257) nswap: 0
2025-10-31 08:41:39,404 - DEBUG - ya.test - _save_outputs: Command (pid 3243257) nvcsw: 554
2025-10-31 08:41:39,404 - DEBUG - ya.test - _save_outputs: Command (pid 3243257) oublock: 80
2025-10-31 08:41:39,404 - DEBUG - ya.test - _save_outputs: Command (pid 3243257) stime: 0.05531
2025-10-31 08:41:39,404 - DEBUG - ya.test - _save_outputs: Command (pid 3243257) utime: 0.05531
2025-10-31 08:41:39,405 - DEBUG - ya.test - _save_outputs: Command (pid 3243257) wtime: 0.17
2025-10-31 08:41:39,405 - DEBUG - ya.test - _save_outputs: Command (pid 3243257) output:

2025-10-31 08:41:39,405 - DEBUG - ya.test - _save_outputs: Command (pid 3243257) errors:
Elapsed: 0.0215 sec. Total read size: 290B. Average processing speed: 13.2KiB/s.


2025-10-31 08:41:39,405 - DEBUG - __tests__.test_ydb_impex - execute_ydb_cli_command: std_out:

2025-10-31 08:41:39,406 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001e92/ydb/apps/ydb/ydb
2025-10-31 08:41:39,407 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.0
2025-10-31 08:41:39,407 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001e92/ydb/apps/ydb/ydb', '--endpoint', 'grpc://localhost:5802', '--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 08:41:39,408 - DEBUG - ya.test - execute: Command pid: 3243480
2025-10-31 08:41:39,637 - DEBUG - ya.test - _save_outputs: Command (pid 3243480) rc: 0
2025-10-31 08:41:39,637 - DEBUG - ya.test - _save_outputs: Command (pid 3243480) elapsed time (sec): 0.2279503345489502
2025-10-31 08:41:39,638 - DEBUG - ya.test - _save_outputs: Command (pid 3243480) idrss: 0
2025-10-31 08:41:39,638 - DEBUG - ya.test - _save_outputs: Command (pid 3243480) inblock: 0
2025-10-31 08:41:39,638 - DEBUG - ya.test - _save_outputs: Command (pid 3243480) isrss: 0
2025-10-31 08:41:39,638 - DEBUG - ya.test - _save_outputs: Command (pid 3243480) ixrss: 0
2025-10-31 08:41:39,638 - DEBUG - ya.test - _save_outputs: Command (pid 3243480) majflt: 0
2025-10-31 08:41:39,639 - DEBUG - ya.test - _save_outputs: Command (pid 3243480) maxrss: 184408
2025-10-31 08:41:39,639 - DEBUG - ya.test - _save_outputs: Command (pid 3243480) minflt: 3457
2025-10-31 08:41:39,639 - DEBUG - ya.test - _save_outputs: Command (pid 3243480) msgrcv: 0
2025-10-31 08:41:39,639 - DEBUG - ya.test - _save_outputs: Command (pid 3243480) msgsnd: 0
2025-10-31 08:41:39,639 - DEBUG - ya.test - _save_outputs: Command (pid 3243480) nivcsw: 4
2025-10-31 08:41:39,639 - DEBUG - ya.test - _save_outputs: Command (pid 3243480) nsignals: 0
2025-10-31 08:41:39,640 - DEBUG - ya.test - _save_outputs: Command (pid 3243480) nswap: 0
2025-10-31 08:41:39,640 - DEBUG - ya.test - _save_outputs: Command (pid 3243480) nvcsw: 202
2025-10-31 08:41:39,640 - DEBUG - ya.test - _save_outputs: Command (pid 3243480) oublock: 8
2025-10-31 08:41:39,640 - DEBUG - ya.test - _save_outputs: Command (pid 3243480) stime: 0.022076
2025-10-31 08:41:39,640 - DEBUG - ya.test - _save_outputs: Command (pid 3243480) utime: 0.058871
2025-10-31 08:41:39,640 - DEBUG - ya.test - _save_outputs: Command (pid 3243480) wtime: 0.229
2025-10-31 08:41:39,641 - DEBUG - ya.test - _save_outputs: Command (pid 3243480) 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 08:41:39,641 - DEBUG - ya.test - _save_outputs: Command (pid 3243480) errors:

2025-10-31 08:41:39,641 - 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 08:41:39,643 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-10-31 08:42:03,440 - 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 08:42:03,445 - DEBUG - ya.test - verify: Test test_ydb_impex.TestImpex.test_multiple_files_and_stdin[tsv-additional_args2-column] status: good
