2025-10-31 08:41:40,028 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-31 08:41:40,028 - INFO - ya.test - pytest_runtest_setup: test_multiple_files_and_stdin[tsv-additional_args3-column]
2025-10-31 08:41:40,028 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-31 08:41:40,028 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-31 08:41:40,030 - 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-10-31 08:41:40,031 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, 42f8a039-93e8-4789-99ea-2895fd9b8ee0, ghrun-uabpkrvm6i.auto.internal:5802): creating call state
2025-10-31 08:41:40,032 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, 42f8a039-93e8-4789-99ea-2895fd9b8ee0, 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_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-10-31 08:41:40,387 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, 42f8a039-93e8-4789-99ea-2895fd9b8ee0, ghrun-uabpkrvm6i.auto.internal:5802): response = { operation { ready: true status: SUCCESS } }
2025-10-31 08:41:40,389 - 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:40,390 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.1
2025-10-31 08:41:40,390 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.3
2025-10-31 08:41:40,391 - 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_args3-column]', '--header', '--newline-delimited', '/home/runner/.ya/build/build_root/pogg/001e92/tmp/test_multiple_files_and_stdin_2/tempinput0.tsv', '/home/runner/.ya/build/build_root/pogg/001e92/tmp/test_multiple_files_and_stdin_2/tempinput1.tsv', '/home/runner/.ya/build/build_root/pogg/001e92/tmp/test_multiple_files_and_stdin_2/tempinput2.tsv', '/home/runner/.ya/build/build_root/pogg/001e92/tmp/test_multiple_files_and_stdin_2/tempinput3.tsv']' in 'None' (waiting)
2025-10-31 08:41:40,392 - DEBUG - ya.test - execute: Command pid: 3243995
2025-10-31 08:41:40,558 - DEBUG - ya.test - _save_outputs: Command (pid 3243995) rc: 0
2025-10-31 08:41:40,559 - DEBUG - ya.test - _save_outputs: Command (pid 3243995) elapsed time (sec): 0.16581249237060547
2025-10-31 08:41:40,559 - DEBUG - ya.test - _save_outputs: Command (pid 3243995) idrss: 0
2025-10-31 08:41:40,559 - DEBUG - ya.test - _save_outputs: Command (pid 3243995) inblock: 0
2025-10-31 08:41:40,559 - DEBUG - ya.test - _save_outputs: Command (pid 3243995) isrss: 0
2025-10-31 08:41:40,559 - DEBUG - ya.test - _save_outputs: Command (pid 3243995) ixrss: 0
2025-10-31 08:41:40,559 - DEBUG - ya.test - _save_outputs: Command (pid 3243995) majflt: 0
2025-10-31 08:41:40,560 - DEBUG - ya.test - _save_outputs: Command (pid 3243995) maxrss: 184408
2025-10-31 08:41:40,560 - DEBUG - ya.test - _save_outputs: Command (pid 3243995) minflt: 4419
2025-10-31 08:41:40,560 - DEBUG - ya.test - _save_outputs: Command (pid 3243995) msgrcv: 0
2025-10-31 08:41:40,560 - DEBUG - ya.test - _save_outputs: Command (pid 3243995) msgsnd: 0
2025-10-31 08:41:40,560 - DEBUG - ya.test - _save_outputs: Command (pid 3243995) nivcsw: 12
2025-10-31 08:41:40,560 - DEBUG - ya.test - _save_outputs: Command (pid 3243995) nsignals: 0
2025-10-31 08:41:40,561 - DEBUG - ya.test - _save_outputs: Command (pid 3243995) nswap: 0
2025-10-31 08:41:40,561 - DEBUG - ya.test - _save_outputs: Command (pid 3243995) nvcsw: 886
2025-10-31 08:41:40,561 - DEBUG - ya.test - _save_outputs: Command (pid 3243995) oublock: 48
2025-10-31 08:41:40,561 - DEBUG - ya.test - _save_outputs: Command (pid 3243995) stime: 0.048583
2025-10-31 08:41:40,561 - DEBUG - ya.test - _save_outputs: Command (pid 3243995) utime: 0.068016
2025-10-31 08:41:40,562 - DEBUG - ya.test - _save_outputs: Command (pid 3243995) wtime: 0.167
2025-10-31 08:41:40,562 - DEBUG - ya.test - _save_outputs: Command (pid 3243995) output:

2025-10-31 08:41:40,562 - DEBUG - ya.test - _save_outputs: Command (pid 3243995) errors:
Elapsed: 0.0208 sec. Total read size: 290B. Average processing speed: 13.6KiB/s.


2025-10-31 08:41:40,562 - DEBUG - __tests__.test_ydb_impex - execute_ydb_cli_command: std_out:

2025-10-31 08:41:40,563 - 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:40,564 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.4
2025-10-31 08:41:40,564 - 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_args3-column]` ORDER BY `key`', '-t', 'scan', '--format', 'tsv']' in 'None' (waiting)
2025-10-31 08:41:40,565 - DEBUG - ya.test - execute: Command pid: 3244267
2025-10-31 08:41:40,758 - DEBUG - ya.test - _save_outputs: Command (pid 3244267) rc: 0
2025-10-31 08:41:40,759 - DEBUG - ya.test - _save_outputs: Command (pid 3244267) elapsed time (sec): 0.19227194786071777
2025-10-31 08:41:40,759 - DEBUG - ya.test - _save_outputs: Command (pid 3244267) idrss: 0
2025-10-31 08:41:40,759 - DEBUG - ya.test - _save_outputs: Command (pid 3244267) inblock: 0
2025-10-31 08:41:40,759 - DEBUG - ya.test - _save_outputs: Command (pid 3244267) isrss: 0
2025-10-31 08:41:40,759 - DEBUG - ya.test - _save_outputs: Command (pid 3244267) ixrss: 0
2025-10-31 08:41:40,759 - DEBUG - ya.test - _save_outputs: Command (pid 3244267) majflt: 0
2025-10-31 08:41:40,760 - DEBUG - ya.test - _save_outputs: Command (pid 3244267) maxrss: 184408
2025-10-31 08:41:40,760 - DEBUG - ya.test - _save_outputs: Command (pid 3244267) minflt: 3437
2025-10-31 08:41:40,760 - DEBUG - ya.test - _save_outputs: Command (pid 3244267) msgrcv: 0
2025-10-31 08:41:40,760 - DEBUG - ya.test - _save_outputs: Command (pid 3244267) msgsnd: 0
2025-10-31 08:41:40,760 - DEBUG - ya.test - _save_outputs: Command (pid 3244267) nivcsw: 4
2025-10-31 08:41:40,760 - DEBUG - ya.test - _save_outputs: Command (pid 3244267) nsignals: 0
2025-10-31 08:41:40,761 - DEBUG - ya.test - _save_outputs: Command (pid 3244267) nswap: 0
2025-10-31 08:41:40,761 - DEBUG - ya.test - _save_outputs: Command (pid 3244267) nvcsw: 183
2025-10-31 08:41:40,761 - DEBUG - ya.test - _save_outputs: Command (pid 3244267) oublock: 8
2025-10-31 08:41:40,761 - DEBUG - ya.test - _save_outputs: Command (pid 3244267) stime: 0.031858
2025-10-31 08:41:40,761 - DEBUG - ya.test - _save_outputs: Command (pid 3244267) utime: 0.050061999999999995
2025-10-31 08:41:40,761 - DEBUG - ya.test - _save_outputs: Command (pid 3244267) wtime: 0.193
2025-10-31 08:41:40,762 - DEBUG - ya.test - _save_outputs: Command (pid 3244267) 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:40,762 - DEBUG - ya.test - _save_outputs: Command (pid 3244267) errors:

2025-10-31 08:41:40,762 - 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:40,764 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-10-31 08:42:02,767 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:5802/1
2025-10-31 08:42:02,768 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/19578
2025-10-31 08:42:02,768 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/18245
2025-10-31 08:42:02,768 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/28055
2025-10-31 08:42:02,768 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/5802
2025-10-31 08:42:02,769 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/1393
2025-10-31 08:42:03,449 - 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-10-31 08:42:03,450 - DEBUG - ya.test - verify: Test test_ydb_impex.TestImpex.test_multiple_files_and_stdin[tsv-additional_args3-column] status: good
