2025-11-01 16:50:28,474 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 16:50:28,475 - INFO - ya.test - pytest_runtest_setup: test_multiple_files[tsv-additional_args3-row]
2025-11-01 16:50:28,475 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 16:50:28,475 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-01 16:50:28,594 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/q6a6/001b30/ydb/apps/ydbd/ydbd
2025-11-01 16:50:28,603 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/3221
2025-11-01 16:50:28,604 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/q6a6/001b30/r3tmp/kikimr_cluster_63v6iakg
2025-11-01 16:50:28,645 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/q6a6/001b30/ydb/apps/ydbd/ydbd
2025-11-01 16:50:28,645 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/7067
2025-11-01 16:50:28,646 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/11405
2025-11-01 16:50:28,646 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/21827
2025-11-01 16:50:28,646 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/9715
2025-11-01 16:50:28,647 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/q6a6/001b30/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk17/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files.tsv-additional_args3-row/cluster/kikimr_configs"
2025-11-01 16:50:28,648 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/q6a6/001b30/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/q6a6/001b30/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk17/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files.tsv-additional_args3-row/cluster/node_1/logfile_cey8u981.log --grpc-port=7067 --mon-port=11405 --ic-port=3221
2025-11-01 16:50:28,648 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:7067/1, disk_size 68719476736
2025-11-01 16:50:28,648 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/q6a6/001b30/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk17/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files.tsv-additional_args3-row/cluster/kikimr_configs"
2025-11-01 16:50:28,648 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/q6a6/001b30/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/q6a6/001b30/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk17/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files.tsv-additional_args3-row/cluster/node_1/logfile_cey8u981.log --grpc-port=7067 --mon-port=11405 --ic-port=3221
2025-11-01 16:50:28,649 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/q6a6/001b30/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/q6a6/001b30/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk17/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files.tsv-additional_args3-row/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/q6a6/001b30/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk17/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files.tsv-additional_args3-row/cluster/node_1/logfile_cey8u981.log', '--grpc-port=7067', '--mon-port=11405', '--ic-port=3221')' in '/home/runner/.ya/build/build_root/q6a6/001b30/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_impex/chunk17/testing_out_stuff/test_ydb_impex.py.TestImpex.test_multiple_files.tsv-additional_args3-row/cluster/node_1' (no wait)
2025-11-01 16:50:28,656 - DEBUG - ya.test - execute: Command pid: 3222924
2025-11-01 16:50:28,658 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:7067/1
2025-11-01 16:50:28,659 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-01 16:50:28,660 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-01 16:50:28,661 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/q6a6/001b30/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 16:50:28,662 - DEBUG - ya.test - execute: Command pid: 3222933
2025-11-01 16:50:29,534 - DEBUG - ya.test - _save_outputs: Command (pid 3222933) rc: 0
2025-11-01 16:50:29,535 - DEBUG - ya.test - _save_outputs: Command (pid 3222933) elapsed time (sec): 0.8714146614074707
2025-11-01 16:50:29,535 - DEBUG - ya.test - _save_outputs: Command (pid 3222933) idrss: 0
2025-11-01 16:50:29,535 - DEBUG - ya.test - _save_outputs: Command (pid 3222933) inblock: 0
2025-11-01 16:50:29,535 - DEBUG - ya.test - _save_outputs: Command (pid 3222933) isrss: 0
2025-11-01 16:50:29,535 - DEBUG - ya.test - _save_outputs: Command (pid 3222933) ixrss: 0
2025-11-01 16:50:29,535 - DEBUG - ya.test - _save_outputs: Command (pid 3222933) majflt: 0
2025-11-01 16:50:29,536 - DEBUG - ya.test - _save_outputs: Command (pid 3222933) maxrss: 538568
2025-11-01 16:50:29,536 - DEBUG - ya.test - _save_outputs: Command (pid 3222933) minflt: 16342
2025-11-01 16:50:29,536 - DEBUG - ya.test - _save_outputs: Command (pid 3222933) msgrcv: 0
2025-11-01 16:50:29,536 - DEBUG - ya.test - _save_outputs: Command (pid 3222933) msgsnd: 0
2025-11-01 16:50:29,536 - DEBUG - ya.test - _save_outputs: Command (pid 3222933) nivcsw: 154
2025-11-01 16:50:29,536 - DEBUG - ya.test - _save_outputs: Command (pid 3222933) nsignals: 0
2025-11-01 16:50:29,536 - DEBUG - ya.test - _save_outputs: Command (pid 3222933) nswap: 0
2025-11-01 16:50:29,537 - DEBUG - ya.test - _save_outputs: Command (pid 3222933) nvcsw: 40
2025-11-01 16:50:29,537 - DEBUG - ya.test - _save_outputs: Command (pid 3222933) oublock: 8
2025-11-01 16:50:29,537 - DEBUG - ya.test - _save_outputs: Command (pid 3222933) stime: 0.593424
2025-11-01 16:50:29,537 - DEBUG - ya.test - _save_outputs: Command (pid 3222933) utime: 0.118975
2025-11-01 16:50:29,537 - DEBUG - ya.test - _save_outputs: Command (pid 3222933) wtime: 0.873
2025-11-01 16:50:29,537 - DEBUG - ya.test - _save_outputs: Command (pid 3222933) output:
Git info:
    Commit: 34ddad56c8a7bb530ecf731d374c04f98d3d2aca
    Branch: 
    Author: azevaykin <145343289+azevaykin@users.noreply.github.com>
    Summary: Merge f53a17d638f4ee7a8f08354cd76c33a88c4925c5 into 5dbd26ce2068671edb74bb9f072505a44ea73d1e

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-tvlw7frnpa
    Host information: 
        Linux ghrun-tvlw7frnpa 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 16:50:29,537 - DEBUG - ya.test - _save_outputs: Command (pid 3222933) errors:

2025-11-01 16:50:29,538 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 34ddad56c8a7bb530ecf731d374c04f98d3d2aca
    Branch: 
    Author: azevaykin <145343289+azevaykin@users.noreply.github.com>
    Summary: Merge f53a17d638f4ee7a8f08354cd76c33a88c4925c5 into 5dbd26ce2068671edb74bb9f072505a44ea73d1e
2025-11-01 16:50:33,845 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/q6a6/001b30/ydb/apps/ydbd/ydbd
2025-11-01 16:50:33,866 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/q6a6/001b30/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:7067', '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: 3221\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-01 16:50:33,867 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-01 16:50:33,868 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-01 16:50:33,869 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/q6a6/001b30/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:7067', '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: 3221\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-01 16:50:33,870 - DEBUG - ya.test - execute: Command pid: 3226779
2025-11-01 16:50:34,378 - DEBUG - ya.test - _save_outputs: Command (pid 3226779) rc: 0
2025-11-01 16:50:34,379 - DEBUG - ya.test - _save_outputs: Command (pid 3226779) elapsed time (sec): 0.5067646503448486
2025-11-01 16:50:34,379 - DEBUG - ya.test - _save_outputs: Command (pid 3226779) idrss: 0
2025-11-01 16:50:34,379 - DEBUG - ya.test - _save_outputs: Command (pid 3226779) inblock: 0
2025-11-01 16:50:34,379 - DEBUG - ya.test - _save_outputs: Command (pid 3226779) isrss: 0
2025-11-01 16:50:34,379 - DEBUG - ya.test - _save_outputs: Command (pid 3226779) ixrss: 0
2025-11-01 16:50:34,380 - DEBUG - ya.test - _save_outputs: Command (pid 3226779) majflt: 0
2025-11-01 16:50:34,380 - DEBUG - ya.test - _save_outputs: Command (pid 3226779) maxrss: 546964
2025-11-01 16:50:34,380 - DEBUG - ya.test - _save_outputs: Command (pid 3226779) minflt: 18271
2025-11-01 16:50:34,380 - DEBUG - ya.test - _save_outputs: Command (pid 3226779) msgrcv: 0
2025-11-01 16:50:34,380 - DEBUG - ya.test - _save_outputs: Command (pid 3226779) msgsnd: 0
2025-11-01 16:50:34,380 - DEBUG - ya.test - _save_outputs: Command (pid 3226779) nivcsw: 138
2025-11-01 16:50:34,381 - DEBUG - ya.test - _save_outputs: Command (pid 3226779) nsignals: 0
2025-11-01 16:50:34,381 - DEBUG - ya.test - _save_outputs: Command (pid 3226779) nswap: 0
2025-11-01 16:50:34,381 - DEBUG - ya.test - _save_outputs: Command (pid 3226779) nvcsw: 127
2025-11-01 16:50:34,381 - DEBUG - ya.test - _save_outputs: Command (pid 3226779) oublock: 8
2025-11-01 16:50:34,381 - DEBUG - ya.test - _save_outputs: Command (pid 3226779) stime: 0.312455
2025-11-01 16:50:34,381 - DEBUG - ya.test - _save_outputs: Command (pid 3226779) utime: 0.11604199999999999
2025-11-01 16:50:34,382 - DEBUG - ya.test - _save_outputs: Command (pid 3226779) wtime: 0.508
2025-11-01 16:50:34,382 - DEBUG - ya.test - _save_outputs: Command (pid 3226779) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 4

2025-11-01 16:50:34,382 - DEBUG - ya.test - _save_outputs: Command (pid 3226779) errors:

2025-11-01 16:50:34,383 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/q6a6/001b30/ydb/apps/ydbd/ydbd
2025-11-01 16:50:34,383 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/q6a6/001b30/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:7067', '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 16:50:34,384 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-01 16:50:34,385 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-01 16:50:34,385 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/q6a6/001b30/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:7067', '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 16:50:34,386 - DEBUG - ya.test - execute: Command pid: 3227167
2025-11-01 16:50:35,335 - DEBUG - ya.test - _save_outputs: Command (pid 3227167) rc: 0
2025-11-01 16:50:35,336 - DEBUG - ya.test - _save_outputs: Command (pid 3227167) elapsed time (sec): 0.9475917816162109
2025-11-01 16:50:35,336 - DEBUG - ya.test - _save_outputs: Command (pid 3227167) idrss: 0
2025-11-01 16:50:35,342 - DEBUG - ya.test - _save_outputs: Command (pid 3227167) inblock: 0
2025-11-01 16:50:35,343 - DEBUG - ya.test - _save_outputs: Command (pid 3227167) isrss: 0
2025-11-01 16:50:35,344 - DEBUG - ya.test - _save_outputs: Command (pid 3227167) ixrss: 0
2025-11-01 16:50:35,345 - DEBUG - ya.test - _save_outputs: Command (pid 3227167) majflt: 0
2025-11-01 16:50:35,349 - DEBUG - ya.test - _save_outputs: Command (pid 3227167) maxrss: 546940
2025-11-01 16:50:35,351 - DEBUG - ya.test - _save_outputs: Command (pid 3227167) minflt: 18276
2025-11-01 16:50:35,351 - DEBUG - ya.test - _save_outputs: Command (pid 3227167) msgrcv: 0
2025-11-01 16:50:35,352 - DEBUG - ya.test - _save_outputs: Command (pid 3227167) msgsnd: 0
2025-11-01 16:50:35,352 - DEBUG - ya.test - _save_outputs: Command (pid 3227167) nivcsw: 135
2025-11-01 16:50:35,357 - DEBUG - ya.test - _save_outputs: Command (pid 3227167) nsignals: 0
2025-11-01 16:50:35,358 - DEBUG - ya.test - _save_outputs: Command (pid 3227167) nswap: 0
2025-11-01 16:50:35,371 - DEBUG - ya.test - _save_outputs: Command (pid 3227167) nvcsw: 140
2025-11-01 16:50:35,373 - DEBUG - ya.test - _save_outputs: Command (pid 3227167) oublock: 8
2025-11-01 16:50:35,373 - DEBUG - ya.test - _save_outputs: Command (pid 3227167) stime: 0.469636
2025-11-01 16:50:35,378 - DEBUG - ya.test - _save_outputs: Command (pid 3227167) utime: 0.126969
2025-11-01 16:50:35,379 - DEBUG - ya.test - _save_outputs: Command (pid 3227167) wtime: 0.949
2025-11-01 16:50:35,379 - DEBUG - ya.test - _save_outputs: Command (pid 3227167) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-01 16:50:35,379 - DEBUG - ya.test - _save_outputs: Command (pid 3227167) errors:

2025-11-01 16:50:35,380 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-01 16:50:35,437 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-01 16:50:35,460 - 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 16:50:35,471 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 16:50:35,471 - 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 16:50:35,497 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-01 16:50:35,497 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 914f2378-fd86-4def-a281-a8ddc71b3b36, localhost:7067): creating call state
2025-11-01 16:50:35,498 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 914f2378-fd86-4def-a281-a8ddc71b3b36, localhost:7067): request = { database: "/Root" }
2025-11-01 16:50:35,505 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 914f2378-fd86-4def-a281-a8ddc71b3b36, localhost:7067): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-tvlw7frnpa.auto.internal" port: 7067 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 16:50:35,510 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-tvlw7frnpa.auto.internal:7067, location 1, ssl: False>]>
2025-11-01 16:50:35,514 - 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 16:50:35,559 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:7067
2025-11-01 16:50:35,562 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, ef7d7194-3e78-4d65-a7d3-99d101ce32b7, ghrun-tvlw7frnpa.auto.internal:7067): creating call state
2025-11-01 16:50:35,575 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, ef7d7194-3e78-4d65-a7d3-99d101ce32b7, ghrun-tvlw7frnpa.auto.internal:7067): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:50:35,583 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, ef7d7194-3e78-4d65-a7d3-99d101ce32b7, ghrun-tvlw7frnpa.auto.internal:7067): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=ZjEzYzg4MzItYjY1YzE0NjctMWJlNmNjOS0zZDJmMzVhNg==" } } } }
2025-11-01 16:50:35,610 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_ydb_impex.py::TestImpex, test_name: test_multiple_files[tsv-additional_args3-row])
2025-11-01 16:50:35,611 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, 3cd838f0-f320-4b9f-8f21-d3c1aef0d6a4, ghrun-tvlw7frnpa.auto.internal:7067): creating call state
2025-11-01 16:50:35,613 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, 3cd838f0-f320-4b9f-8f21-d3c1aef0d6a4, ghrun-tvlw7frnpa.auto.internal:7067): request = { session_id: "ydb://session/3?node_id=1&id=ZjEzYzg4MzItYjY1YzE0NjctMWJlNmNjOS0zZDJmMzVhNg==" yql_text: "\n        CREATE TABLE `/Root/test_multiple_files[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 16:50:35,683 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, 3cd838f0-f320-4b9f-8f21-d3c1aef0d6a4, ghrun-tvlw7frnpa.auto.internal:7067): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:50:35,685 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/q6a6/001b30/ydb/apps/ydb/ydb
2025-11-01 16:50:35,686 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out
2025-11-01 16:50:35,686 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err
2025-11-01 16:50:35,687 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/q6a6/001b30/ydb/apps/ydb/ydb', '--endpoint', 'grpc://localhost:7067', '--database', '/Root', 'import', 'file', 'tsv', '-p', '/Root/test_multiple_files[tsv-additional_args3-row]', '--header', '--newline-delimited', '/home/runner/.ya/build/build_root/q6a6/001b30/tmp/test_multiple_files_tsv_additi0/tempinput0.tsv', '/home/runner/.ya/build/build_root/q6a6/001b30/tmp/test_multiple_files_tsv_additi0/tempinput1.tsv', '/home/runner/.ya/build/build_root/q6a6/001b30/tmp/test_multiple_files_tsv_additi0/tempinput2.tsv', '/home/runner/.ya/build/build_root/q6a6/001b30/tmp/test_multiple_files_tsv_additi0/tempinput3.tsv']' in 'None' (waiting)
2025-11-01 16:50:35,688 - DEBUG - ya.test - execute: Command pid: 3227981
2025-11-01 16:50:36,014 - DEBUG - ya.test - _save_outputs: Command (pid 3227981) rc: 0
2025-11-01 16:50:36,015 - DEBUG - ya.test - _save_outputs: Command (pid 3227981) elapsed time (sec): 0.3262009620666504
2025-11-01 16:50:36,015 - DEBUG - ya.test - _save_outputs: Command (pid 3227981) idrss: 0
2025-11-01 16:50:36,015 - DEBUG - ya.test - _save_outputs: Command (pid 3227981) inblock: 0
2025-11-01 16:50:36,015 - DEBUG - ya.test - _save_outputs: Command (pid 3227981) isrss: 0
2025-11-01 16:50:36,015 - DEBUG - ya.test - _save_outputs: Command (pid 3227981) ixrss: 0
2025-11-01 16:50:36,015 - DEBUG - ya.test - _save_outputs: Command (pid 3227981) majflt: 0
2025-11-01 16:50:36,016 - DEBUG - ya.test - _save_outputs: Command (pid 3227981) maxrss: 187424
2025-11-01 16:50:36,016 - DEBUG - ya.test - _save_outputs: Command (pid 3227981) minflt: 4368
2025-11-01 16:50:36,016 - DEBUG - ya.test - _save_outputs: Command (pid 3227981) msgrcv: 0
2025-11-01 16:50:36,016 - DEBUG - ya.test - _save_outputs: Command (pid 3227981) msgsnd: 0
2025-11-01 16:50:36,016 - DEBUG - ya.test - _save_outputs: Command (pid 3227981) nivcsw: 99
2025-11-01 16:50:36,016 - DEBUG - ya.test - _save_outputs: Command (pid 3227981) nsignals: 0
2025-11-01 16:50:36,016 - DEBUG - ya.test - _save_outputs: Command (pid 3227981) nswap: 0
2025-11-01 16:50:36,017 - DEBUG - ya.test - _save_outputs: Command (pid 3227981) nvcsw: 676
2025-11-01 16:50:36,017 - DEBUG - ya.test - _save_outputs: Command (pid 3227981) oublock: 48
2025-11-01 16:50:36,017 - DEBUG - ya.test - _save_outputs: Command (pid 3227981) stime: 0.048277
2025-11-01 16:50:36,017 - DEBUG - ya.test - _save_outputs: Command (pid 3227981) utime: 0.06437
2025-11-01 16:50:36,017 - DEBUG - ya.test - _save_outputs: Command (pid 3227981) wtime: 0.327
2025-11-01 16:50:36,017 - DEBUG - ya.test - _save_outputs: Command (pid 3227981) output:

2025-11-01 16:50:36,018 - DEBUG - ya.test - _save_outputs: Command (pid 3227981) errors:
Elapsed: 0.0399 sec. Total read size: 290B. Average processing speed: 7.1KiB/s.


2025-11-01 16:50:36,018 - DEBUG - __tests__.test_ydb_impex - execute_ydb_cli_command: std_out:

2025-11-01 16:50:36,020 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/q6a6/001b30/ydb/apps/ydb/ydb
2025-11-01 16:50:36,021 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.0
2025-11-01 16:50:36,021 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/q6a6/001b30/ydb/apps/ydb/ydb', '--endpoint', 'grpc://localhost:7067', '--database', '/Root', 'table', 'query', 'execute', '-q', 'SELECT `key`, `id`, `value` FROM `/Root/test_multiple_files[tsv-additional_args3-row]` ORDER BY `key`', '-t', 'scan', '--format', 'tsv']' in 'None' (waiting)
2025-11-01 16:50:36,022 - DEBUG - ya.test - execute: Command pid: 3228431
2025-11-01 16:50:36,196 - DEBUG - ya.test - _save_outputs: Command (pid 3228431) rc: 0
2025-11-01 16:50:36,196 - DEBUG - ya.test - _save_outputs: Command (pid 3228431) elapsed time (sec): 0.17272090911865234
2025-11-01 16:50:36,196 - DEBUG - ya.test - _save_outputs: Command (pid 3228431) idrss: 0
2025-11-01 16:50:36,196 - DEBUG - ya.test - _save_outputs: Command (pid 3228431) inblock: 0
2025-11-01 16:50:36,197 - DEBUG - ya.test - _save_outputs: Command (pid 3228431) isrss: 0
2025-11-01 16:50:36,197 - DEBUG - ya.test - _save_outputs: Command (pid 3228431) ixrss: 0
2025-11-01 16:50:36,197 - DEBUG - ya.test - _save_outputs: Command (pid 3228431) majflt: 0
2025-11-01 16:50:36,197 - DEBUG - ya.test - _save_outputs: Command (pid 3228431) maxrss: 187424
2025-11-01 16:50:36,197 - DEBUG - ya.test - _save_outputs: Command (pid 3228431) minflt: 3427
2025-11-01 16:50:36,197 - DEBUG - ya.test - _save_outputs: Command (pid 3228431) msgrcv: 0
2025-11-01 16:50:36,198 - DEBUG - ya.test - _save_outputs: Command (pid 3228431) msgsnd: 0
2025-11-01 16:50:36,198 - DEBUG - ya.test - _save_outputs: Command (pid 3228431) nivcsw: 29
2025-11-01 16:50:36,198 - DEBUG - ya.test - _save_outputs: Command (pid 3228431) nsignals: 0
2025-11-01 16:50:36,198 - DEBUG - ya.test - _save_outputs: Command (pid 3228431) nswap: 0
2025-11-01 16:50:36,198 - DEBUG - ya.test - _save_outputs: Command (pid 3228431) nvcsw: 140
2025-11-01 16:50:36,198 - DEBUG - ya.test - _save_outputs: Command (pid 3228431) oublock: 8
2025-11-01 16:50:36,199 - DEBUG - ya.test - _save_outputs: Command (pid 3228431) stime: 0.029205
2025-11-01 16:50:36,199 - DEBUG - ya.test - _save_outputs: Command (pid 3228431) utime: 0.036507
2025-11-01 16:50:36,199 - DEBUG - ya.test - _save_outputs: Command (pid 3228431) wtime: 0.174
2025-11-01 16:50:36,199 - DEBUG - ya.test - _save_outputs: Command (pid 3228431) 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 16:50:36,199 - DEBUG - ya.test - _save_outputs: Command (pid 3228431) errors:

2025-11-01 16:50:36,199 - 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 16:50:36,202 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-11-01 16:51:00,239 - DEBUG - ya.test - _verify_test: Verifying [test_ydb_impex.TestImpex.test_multiple_files[tsv-additional_args3-row] in ydb/tests/functional/ydb_cli] canonical results
2025-11-01 16:51:00,255 - DEBUG - ya.test - verify: Test test_ydb_impex.TestImpex.test_multiple_files[tsv-additional_args3-row] status: good
