2025-11-01 16:40:30,176 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 16:40:30,177 - INFO - ya.test - pytest_runtest_setup: test_multiple_files_and_stdin[tsv-additional_args3-column]
2025-11-01 16:40:30,177 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 16:40:30,177 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-01 16:40:30,179 - 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 16:40:30,180 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, 4fc96999-8b11-4f57-a9ff-1c2c110bda2a, ghrun-tvlw7frnpa.auto.internal:24461): creating call state
2025-11-01 16:40:30,180 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, 4fc96999-8b11-4f57-a9ff-1c2c110bda2a, ghrun-tvlw7frnpa.auto.internal:24461): request = { session_id: "ydb://session/3?node_id=1&id=Mjk1MWM2YjAtMmJjNjEzZDYtMzlkYzRjODAtMjNlYjI1OTY=" 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 16:40:30,463 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, 4fc96999-8b11-4f57-a9ff-1c2c110bda2a, ghrun-tvlw7frnpa.auto.internal:24461): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:40:30,465 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/q6a6/001a0a/ydb/apps/ydb/ydb
2025-11-01 16:40:30,466 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.1
2025-11-01 16:40:30,466 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.3
2025-11-01 16:40:30,467 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/q6a6/001a0a/ydb/apps/ydb/ydb', '--endpoint', 'grpc://localhost:24461', '--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/q6a6/001a0a/tmp/test_multiple_files_and_stdin_2/tempinput0.tsv', '/home/runner/.ya/build/build_root/q6a6/001a0a/tmp/test_multiple_files_and_stdin_2/tempinput1.tsv', '/home/runner/.ya/build/build_root/q6a6/001a0a/tmp/test_multiple_files_and_stdin_2/tempinput2.tsv', '/home/runner/.ya/build/build_root/q6a6/001a0a/tmp/test_multiple_files_and_stdin_2/tempinput3.tsv']' in 'None' (waiting)
2025-11-01 16:40:30,467 - DEBUG - ya.test - execute: Command pid: 2842779
2025-11-01 16:40:30,616 - DEBUG - ya.test - _save_outputs: Command (pid 2842779) rc: 0
2025-11-01 16:40:30,617 - DEBUG - ya.test - _save_outputs: Command (pid 2842779) elapsed time (sec): 0.14841341972351074
2025-11-01 16:40:30,617 - DEBUG - ya.test - _save_outputs: Command (pid 2842779) idrss: 0
2025-11-01 16:40:30,617 - DEBUG - ya.test - _save_outputs: Command (pid 2842779) inblock: 0
2025-11-01 16:40:30,617 - DEBUG - ya.test - _save_outputs: Command (pid 2842779) isrss: 0
2025-11-01 16:40:30,618 - DEBUG - ya.test - _save_outputs: Command (pid 2842779) ixrss: 0
2025-11-01 16:40:30,618 - DEBUG - ya.test - _save_outputs: Command (pid 2842779) majflt: 0
2025-11-01 16:40:30,618 - DEBUG - ya.test - _save_outputs: Command (pid 2842779) maxrss: 184060
2025-11-01 16:40:30,618 - DEBUG - ya.test - _save_outputs: Command (pid 2842779) minflt: 4413
2025-11-01 16:40:30,618 - DEBUG - ya.test - _save_outputs: Command (pid 2842779) msgrcv: 0
2025-11-01 16:40:30,618 - DEBUG - ya.test - _save_outputs: Command (pid 2842779) msgsnd: 0
2025-11-01 16:40:30,618 - DEBUG - ya.test - _save_outputs: Command (pid 2842779) nivcsw: 10
2025-11-01 16:40:30,619 - DEBUG - ya.test - _save_outputs: Command (pid 2842779) nsignals: 0
2025-11-01 16:40:30,619 - DEBUG - ya.test - _save_outputs: Command (pid 2842779) nswap: 0
2025-11-01 16:40:30,619 - DEBUG - ya.test - _save_outputs: Command (pid 2842779) nvcsw: 961
2025-11-01 16:40:30,619 - DEBUG - ya.test - _save_outputs: Command (pid 2842779) oublock: 48
2025-11-01 16:40:30,619 - DEBUG - ya.test - _save_outputs: Command (pid 2842779) stime: 0.045884999999999995
2025-11-01 16:40:30,619 - DEBUG - ya.test - _save_outputs: Command (pid 2842779) utime: 0.054813999999999995
2025-11-01 16:40:30,620 - DEBUG - ya.test - _save_outputs: Command (pid 2842779) wtime: 0.149
2025-11-01 16:40:30,620 - DEBUG - ya.test - _save_outputs: Command (pid 2842779) output:

2025-11-01 16:40:30,620 - DEBUG - ya.test - _save_outputs: Command (pid 2842779) errors:
Elapsed: 0.0181 sec. Total read size: 290B. Average processing speed: 15.6KiB/s.


2025-11-01 16:40:30,620 - DEBUG - __tests__.test_ydb_impex - execute_ydb_cli_command: std_out:

2025-11-01 16:40:30,620 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/q6a6/001a0a/ydb/apps/ydb/ydb
2025-11-01 16:40:30,621 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.4
2025-11-01 16:40:30,622 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/q6a6/001a0a/ydb/apps/ydb/ydb', '--endpoint', 'grpc://localhost:24461', '--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 16:40:30,623 - DEBUG - ya.test - execute: Command pid: 2843077
2025-11-01 16:40:30,790 - DEBUG - ya.test - _save_outputs: Command (pid 2843077) rc: 0
2025-11-01 16:40:30,790 - DEBUG - ya.test - _save_outputs: Command (pid 2843077) elapsed time (sec): 0.16657757759094238
2025-11-01 16:40:30,790 - DEBUG - ya.test - _save_outputs: Command (pid 2843077) idrss: 0
2025-11-01 16:40:30,790 - DEBUG - ya.test - _save_outputs: Command (pid 2843077) inblock: 0
2025-11-01 16:40:30,791 - DEBUG - ya.test - _save_outputs: Command (pid 2843077) isrss: 0
2025-11-01 16:40:30,791 - DEBUG - ya.test - _save_outputs: Command (pid 2843077) ixrss: 0
2025-11-01 16:40:30,791 - DEBUG - ya.test - _save_outputs: Command (pid 2843077) majflt: 0
2025-11-01 16:40:30,791 - DEBUG - ya.test - _save_outputs: Command (pid 2843077) maxrss: 184060
2025-11-01 16:40:30,791 - DEBUG - ya.test - _save_outputs: Command (pid 2843077) minflt: 3434
2025-11-01 16:40:30,791 - DEBUG - ya.test - _save_outputs: Command (pid 2843077) msgrcv: 0
2025-11-01 16:40:30,791 - DEBUG - ya.test - _save_outputs: Command (pid 2843077) msgsnd: 0
2025-11-01 16:40:30,792 - DEBUG - ya.test - _save_outputs: Command (pid 2843077) nivcsw: 3
2025-11-01 16:40:30,792 - DEBUG - ya.test - _save_outputs: Command (pid 2843077) nsignals: 0
2025-11-01 16:40:30,792 - DEBUG - ya.test - _save_outputs: Command (pid 2843077) nswap: 0
2025-11-01 16:40:30,792 - DEBUG - ya.test - _save_outputs: Command (pid 2843077) nvcsw: 200
2025-11-01 16:40:30,792 - DEBUG - ya.test - _save_outputs: Command (pid 2843077) oublock: 8
2025-11-01 16:40:30,792 - DEBUG - ya.test - _save_outputs: Command (pid 2843077) stime: 0.024596
2025-11-01 16:40:30,793 - DEBUG - ya.test - _save_outputs: Command (pid 2843077) utime: 0.039354
2025-11-01 16:40:30,793 - DEBUG - ya.test - _save_outputs: Command (pid 2843077) wtime: 0.168
2025-11-01 16:40:30,793 - DEBUG - ya.test - _save_outputs: Command (pid 2843077) 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:40:30,793 - DEBUG - ya.test - _save_outputs: Command (pid 2843077) errors:

2025-11-01 16:40:30,793 - 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:40:30,795 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-11-01 16:40:52,797 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:24461/1
2025-11-01 16:40:52,798 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/63283
2025-11-01 16:40:52,798 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/26134
2025-11-01 16:40:52,799 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/22742
2025-11-01 16:40:52,799 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/24461
2025-11-01 16:40:52,799 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/9816
2025-11-01 16:40:53,342 - 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 16:40:53,343 - DEBUG - ya.test - verify: Test test_ydb_impex.TestImpex.test_multiple_files_and_stdin[tsv-additional_args3-column] status: good
