2025-10-31 08:42:01,742 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-31 08:42:01,742 - INFO - ya.test - pytest_runtest_setup: test_multiple_files[tsv-additional_args2-row]
2025-10-31 08:42:01,742 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-31 08:42:01,742 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-31 08:42:01,744 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_ydb_impex.py::TestImpex, test_name: test_multiple_files[tsv-additional_args2-row])
2025-10-31 08:42:01,745 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, 8da4890e-d301-4e74-a186-af870c287b9d, ghrun-uabpkrvm6i.auto.internal:10052): creating call state
2025-10-31 08:42:01,747 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, 8da4890e-d301-4e74-a186-af870c287b9d, ghrun-uabpkrvm6i.auto.internal:10052): request = { session_id: "ydb://session/3?node_id=1&id=NThhNmY0ODctNDQ3ZDY4NWEtZmE0YjZjNmUtOWE3MDRmYTM=" yql_text: "\n        CREATE TABLE `/Root/test_multiple_files[tsv-additional_args2-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-10-31 08:42:01,774 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, 8da4890e-d301-4e74-a186-af870c287b9d, ghrun-uabpkrvm6i.auto.internal:10052): response = { operation { ready: true status: SUCCESS } }
2025-10-31 08:42:01,778 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001413/ydb/apps/ydb/ydb
2025-10-31 08:42:01,779 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.0
2025-10-31 08:42:01,780 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.1
2025-10-31 08:42:01,780 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001413/ydb/apps/ydb/ydb', '--endpoint', 'grpc://localhost:10052', '--database', '/Root', 'import', 'file', 'tsv', '-p', '/Root/test_multiple_files[tsv-additional_args2-row]', '--header', '/home/runner/.ya/build/build_root/pogg/001413/tmp/test_multiple_files_tsv_additi1/tempinput0.tsv', '/home/runner/.ya/build/build_root/pogg/001413/tmp/test_multiple_files_tsv_additi1/tempinput1.tsv', '/home/runner/.ya/build/build_root/pogg/001413/tmp/test_multiple_files_tsv_additi1/tempinput2.tsv', '/home/runner/.ya/build/build_root/pogg/001413/tmp/test_multiple_files_tsv_additi1/tempinput3.tsv']' in 'None' (waiting)
2025-10-31 08:42:01,781 - DEBUG - ya.test - execute: Command pid: 3258082
2025-10-31 08:42:01,925 - DEBUG - ya.test - _save_outputs: Command (pid 3258082) rc: 0
2025-10-31 08:42:01,926 - DEBUG - ya.test - _save_outputs: Command (pid 3258082) elapsed time (sec): 0.1436753273010254
2025-10-31 08:42:01,926 - DEBUG - ya.test - _save_outputs: Command (pid 3258082) idrss: 0
2025-10-31 08:42:01,926 - DEBUG - ya.test - _save_outputs: Command (pid 3258082) inblock: 0
2025-10-31 08:42:01,926 - DEBUG - ya.test - _save_outputs: Command (pid 3258082) isrss: 0
2025-10-31 08:42:01,926 - DEBUG - ya.test - _save_outputs: Command (pid 3258082) ixrss: 0
2025-10-31 08:42:01,927 - DEBUG - ya.test - _save_outputs: Command (pid 3258082) majflt: 0
2025-10-31 08:42:01,927 - DEBUG - ya.test - _save_outputs: Command (pid 3258082) maxrss: 184388
2025-10-31 08:42:01,927 - DEBUG - ya.test - _save_outputs: Command (pid 3258082) minflt: 4154
2025-10-31 08:42:01,927 - DEBUG - ya.test - _save_outputs: Command (pid 3258082) msgrcv: 0
2025-10-31 08:42:01,927 - DEBUG - ya.test - _save_outputs: Command (pid 3258082) msgsnd: 0
2025-10-31 08:42:01,928 - DEBUG - ya.test - _save_outputs: Command (pid 3258082) nivcsw: 7
2025-10-31 08:42:01,928 - DEBUG - ya.test - _save_outputs: Command (pid 3258082) nsignals: 0
2025-10-31 08:42:01,928 - DEBUG - ya.test - _save_outputs: Command (pid 3258082) nswap: 0
2025-10-31 08:42:01,928 - DEBUG - ya.test - _save_outputs: Command (pid 3258082) nvcsw: 541
2025-10-31 08:42:01,928 - DEBUG - ya.test - _save_outputs: Command (pid 3258082) oublock: 80
2025-10-31 08:42:01,928 - DEBUG - ya.test - _save_outputs: Command (pid 3258082) stime: 0.053894
2025-10-31 08:42:01,929 - DEBUG - ya.test - _save_outputs: Command (pid 3258082) utime: 0.049402999999999996
2025-10-31 08:42:01,929 - DEBUG - ya.test - _save_outputs: Command (pid 3258082) wtime: 0.145
2025-10-31 08:42:01,929 - DEBUG - ya.test - _save_outputs: Command (pid 3258082) output:

2025-10-31 08:42:01,929 - DEBUG - ya.test - _save_outputs: Command (pid 3258082) errors:
Elapsed: 0.00592 sec. Total read size: 290B. Average processing speed: 47.8KiB/s.


2025-10-31 08:42:01,929 - DEBUG - __tests__.test_ydb_impex - execute_ydb_cli_command: std_out:

2025-10-31 08:42:01,930 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001413/ydb/apps/ydb/ydb
2025-10-31 08:42:01,931 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.2
2025-10-31 08:42:01,931 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001413/ydb/apps/ydb/ydb', '--endpoint', 'grpc://localhost:10052', '--database', '/Root', 'table', 'query', 'execute', '-q', 'SELECT `key`, `id`, `value` FROM `/Root/test_multiple_files[tsv-additional_args2-row]` ORDER BY `key`', '-t', 'scan', '--format', 'tsv']' in 'None' (waiting)
2025-10-31 08:42:01,932 - DEBUG - ya.test - execute: Command pid: 3258291
2025-10-31 08:42:02,080 - DEBUG - ya.test - _save_outputs: Command (pid 3258291) rc: 0
2025-10-31 08:42:02,080 - DEBUG - ya.test - _save_outputs: Command (pid 3258291) elapsed time (sec): 0.14719223976135254
2025-10-31 08:42:02,081 - DEBUG - ya.test - _save_outputs: Command (pid 3258291) idrss: 0
2025-10-31 08:42:02,081 - DEBUG - ya.test - _save_outputs: Command (pid 3258291) inblock: 0
2025-10-31 08:42:02,081 - DEBUG - ya.test - _save_outputs: Command (pid 3258291) isrss: 0
2025-10-31 08:42:02,081 - DEBUG - ya.test - _save_outputs: Command (pid 3258291) ixrss: 0
2025-10-31 08:42:02,081 - DEBUG - ya.test - _save_outputs: Command (pid 3258291) majflt: 0
2025-10-31 08:42:02,081 - DEBUG - ya.test - _save_outputs: Command (pid 3258291) maxrss: 184388
2025-10-31 08:42:02,082 - DEBUG - ya.test - _save_outputs: Command (pid 3258291) minflt: 3433
2025-10-31 08:42:02,082 - DEBUG - ya.test - _save_outputs: Command (pid 3258291) msgrcv: 0
2025-10-31 08:42:02,082 - DEBUG - ya.test - _save_outputs: Command (pid 3258291) msgsnd: 0
2025-10-31 08:42:02,082 - DEBUG - ya.test - _save_outputs: Command (pid 3258291) nivcsw: 1
2025-10-31 08:42:02,082 - DEBUG - ya.test - _save_outputs: Command (pid 3258291) nsignals: 0
2025-10-31 08:42:02,082 - DEBUG - ya.test - _save_outputs: Command (pid 3258291) nswap: 0
2025-10-31 08:42:02,082 - DEBUG - ya.test - _save_outputs: Command (pid 3258291) nvcsw: 208
2025-10-31 08:42:02,083 - DEBUG - ya.test - _save_outputs: Command (pid 3258291) oublock: 8
2025-10-31 08:42:02,083 - DEBUG - ya.test - _save_outputs: Command (pid 3258291) stime: 0.033294
2025-10-31 08:42:02,083 - DEBUG - ya.test - _save_outputs: Command (pid 3258291) utime: 0.044392
2025-10-31 08:42:02,083 - DEBUG - ya.test - _save_outputs: Command (pid 3258291) wtime: 0.148
2025-10-31 08:42:02,083 - DEBUG - ya.test - _save_outputs: Command (pid 3258291) 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:42:02,083 - DEBUG - ya.test - _save_outputs: Command (pid 3258291) errors:

2025-10-31 08:42:02,083 - 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:42:02,085 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-10-31 08:42:25,385 - DEBUG - ya.test - _verify_test: Verifying [test_ydb_impex.TestImpex.test_multiple_files[tsv-additional_args2-row] in ydb/tests/functional/ydb_cli] canonical results
2025-10-31 08:42:25,386 - DEBUG - ya.test - verify: Test test_ydb_impex.TestImpex.test_multiple_files[tsv-additional_args2-row] status: good
