2025-11-01 04:20:52,715 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 04:20:52,715 - INFO - ya.test - pytest_runtest_setup: test_multiple_files_and_stdin[tsv-additional_args3-column]
2025-11-01 04:20:52,715 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 04:20:52,715 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-01 04:20:52,717 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_ydb_impex.py::TestImpex, test_name: test_multiple_files_and_stdin[tsv-additional_args3-column])
2025-11-01 04:20:52,717 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, 4e7f4e5c-777d-4f48-ba6d-a6f0b397c942, ghrun-i4gyxlpqdu.auto.internal:11066): creating call state
2025-11-01 04:20:52,718 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, 4e7f4e5c-777d-4f48-ba6d-a6f0b397c942, 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_args3-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,957 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, 4e7f4e5c-777d-4f48-ba6d-a6f0b397c942, ghrun-i4gyxlpqdu.auto.internal:11066): response = { operation { ready: true status: SUCCESS } }
2025-11-01 04:20:52,958 - 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,959 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.1
2025-11-01 04:20:52,959 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.3
2025-11-01 04:20:52,960 - 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_args3-column]', '--header', '--newline-delimited', '/home/runner/.ya/build/build_root/g81u/004d96/tmp/test_multiple_files_and_stdin_2/tempinput0.tsv', '/home/runner/.ya/build/build_root/g81u/004d96/tmp/test_multiple_files_and_stdin_2/tempinput1.tsv', '/home/runner/.ya/build/build_root/g81u/004d96/tmp/test_multiple_files_and_stdin_2/tempinput2.tsv', '/home/runner/.ya/build/build_root/g81u/004d96/tmp/test_multiple_files_and_stdin_2/tempinput3.tsv']' in 'None' (waiting)
2025-11-01 04:20:52,960 - DEBUG - ya.test - execute: Command pid: 2581739
2025-11-01 04:20:53,095 - DEBUG - ya.test - _save_outputs: Command (pid 2581739) rc: 0
2025-11-01 04:20:53,096 - DEBUG - ya.test - _save_outputs: Command (pid 2581739) elapsed time (sec): 0.13460993766784668
2025-11-01 04:20:53,096 - DEBUG - ya.test - _save_outputs: Command (pid 2581739) idrss: 0
2025-11-01 04:20:53,096 - DEBUG - ya.test - _save_outputs: Command (pid 2581739) inblock: 0
2025-11-01 04:20:53,096 - DEBUG - ya.test - _save_outputs: Command (pid 2581739) isrss: 0
2025-11-01 04:20:53,096 - DEBUG - ya.test - _save_outputs: Command (pid 2581739) ixrss: 0
2025-11-01 04:20:53,096 - DEBUG - ya.test - _save_outputs: Command (pid 2581739) majflt: 0
2025-11-01 04:20:53,097 - DEBUG - ya.test - _save_outputs: Command (pid 2581739) maxrss: 184488
2025-11-01 04:20:53,097 - DEBUG - ya.test - _save_outputs: Command (pid 2581739) minflt: 4406
2025-11-01 04:20:53,097 - DEBUG - ya.test - _save_outputs: Command (pid 2581739) msgrcv: 0
2025-11-01 04:20:53,097 - DEBUG - ya.test - _save_outputs: Command (pid 2581739) msgsnd: 0
2025-11-01 04:20:53,097 - DEBUG - ya.test - _save_outputs: Command (pid 2581739) nivcsw: 0
2025-11-01 04:20:53,097 - DEBUG - ya.test - _save_outputs: Command (pid 2581739) nsignals: 0
2025-11-01 04:20:53,097 - DEBUG - ya.test - _save_outputs: Command (pid 2581739) nswap: 0
2025-11-01 04:20:53,097 - DEBUG - ya.test - _save_outputs: Command (pid 2581739) nvcsw: 920
2025-11-01 04:20:53,097 - DEBUG - ya.test - _save_outputs: Command (pid 2581739) oublock: 48
2025-11-01 04:20:53,097 - DEBUG - ya.test - _save_outputs: Command (pid 2581739) stime: 0.035962999999999995
2025-11-01 04:20:53,098 - DEBUG - ya.test - _save_outputs: Command (pid 2581739) utime: 0.056513
2025-11-01 04:20:53,098 - DEBUG - ya.test - _save_outputs: Command (pid 2581739) wtime: 0.135
2025-11-01 04:20:53,098 - DEBUG - ya.test - _save_outputs: Command (pid 2581739) output:

2025-11-01 04:20:53,098 - DEBUG - ya.test - _save_outputs: Command (pid 2581739) errors:
Elapsed: 0.0161 sec. Total read size: 290B. Average processing speed: 17.6KiB/s.


2025-11-01 04:20:53,098 - DEBUG - __tests__.test_ydb_impex - execute_ydb_cli_command: std_out:

2025-11-01 04:20:53,098 - 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:53,099 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.4
2025-11-01 04:20:53,099 - 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_args3-column]` ORDER BY `key`', '-t', 'scan', '--format', 'tsv']' in 'None' (waiting)
2025-11-01 04:20:53,100 - DEBUG - ya.test - execute: Command pid: 2581978
2025-11-01 04:20:53,250 - DEBUG - ya.test - _save_outputs: Command (pid 2581978) rc: 0
2025-11-01 04:20:53,250 - DEBUG - ya.test - _save_outputs: Command (pid 2581978) elapsed time (sec): 0.1497819423675537
2025-11-01 04:20:53,251 - DEBUG - ya.test - _save_outputs: Command (pid 2581978) idrss: 0
2025-11-01 04:20:53,251 - DEBUG - ya.test - _save_outputs: Command (pid 2581978) inblock: 0
2025-11-01 04:20:53,251 - DEBUG - ya.test - _save_outputs: Command (pid 2581978) isrss: 0
2025-11-01 04:20:53,251 - DEBUG - ya.test - _save_outputs: Command (pid 2581978) ixrss: 0
2025-11-01 04:20:53,251 - DEBUG - ya.test - _save_outputs: Command (pid 2581978) majflt: 0
2025-11-01 04:20:53,251 - DEBUG - ya.test - _save_outputs: Command (pid 2581978) maxrss: 184488
2025-11-01 04:20:53,251 - DEBUG - ya.test - _save_outputs: Command (pid 2581978) minflt: 3436
2025-11-01 04:20:53,251 - DEBUG - ya.test - _save_outputs: Command (pid 2581978) msgrcv: 0
2025-11-01 04:20:53,251 - DEBUG - ya.test - _save_outputs: Command (pid 2581978) msgsnd: 0
2025-11-01 04:20:53,251 - DEBUG - ya.test - _save_outputs: Command (pid 2581978) nivcsw: 2
2025-11-01 04:20:53,252 - DEBUG - ya.test - _save_outputs: Command (pid 2581978) nsignals: 0
2025-11-01 04:20:53,252 - DEBUG - ya.test - _save_outputs: Command (pid 2581978) nswap: 0
2025-11-01 04:20:53,252 - DEBUG - ya.test - _save_outputs: Command (pid 2581978) nvcsw: 194
2025-11-01 04:20:53,252 - DEBUG - ya.test - _save_outputs: Command (pid 2581978) oublock: 8
2025-11-01 04:20:53,252 - DEBUG - ya.test - _save_outputs: Command (pid 2581978) stime: 0.017075
2025-11-01 04:20:53,252 - DEBUG - ya.test - _save_outputs: Command (pid 2581978) utime: 0.038416
2025-11-01 04:20:53,252 - DEBUG - ya.test - _save_outputs: Command (pid 2581978) wtime: 0.151
2025-11-01 04:20:53,252 - DEBUG - ya.test - _save_outputs: Command (pid 2581978) 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:53,252 - DEBUG - ya.test - _save_outputs: Command (pid 2581978) errors:

2025-11-01 04:20:53,253 - 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:53,254 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-11-01 04:21:15,256 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:11066/1
2025-11-01 04:21:15,257 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/17253
2025-11-01 04:21:15,257 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/16589
2025-11-01 04:21:15,257 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/7355
2025-11-01 04:21:15,257 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/11066
2025-11-01 04:21:15,258 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/28605
2025-11-01 04:21:15,826 - DEBUG - ya.test - _verify_test: Verifying [test_ydb_impex.TestImpex.test_multiple_files_and_stdin[tsv-additional_args3-column] in ydb/tests/functional/ydb_cli] canonical results
2025-11-01 04:21:15,827 - DEBUG - ya.test - verify: Test test_ydb_impex.TestImpex.test_multiple_files_and_stdin[tsv-additional_args3-column] status: good
