2025-11-01 04:29:56,071 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 04:29:56,072 - INFO - ya.test - pytest_runtest_setup: test_multiple_files[tsv-additional_args2-row]
2025-11-01 04:29:56,072 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 04:29:56,073 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-01 04:29:56,087 - 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-11-01 04:29:56,088 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, d22054a4-e765-47c3-9264-29101363f3d0, ghrun-i4gyxlpqdu.auto.internal:28853): creating call state
2025-11-01 04:29:56,089 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, d22054a4-e765-47c3-9264-29101363f3d0, ghrun-i4gyxlpqdu.auto.internal:28853): request = { session_id: "ydb://session/3?node_id=1&id=MzZlN2M5ZTAtZTRkNWVmZmQtOTAyNGQ4MzEtM2QxY2VhNGY=" 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-11-01 04:29:56,153 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, d22054a4-e765-47c3-9264-29101363f3d0, ghrun-i4gyxlpqdu.auto.internal:28853): response = { operation { ready: true status: SUCCESS } }
2025-11-01 04:29:56,195 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004d80/ydb/apps/ydb/ydb
2025-11-01 04:29:56,196 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.0
2025-11-01 04:29:56,197 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.1
2025-11-01 04:29:56,197 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004d80/ydb/apps/ydb/ydb', '--endpoint', 'grpc://localhost:28853', '--database', '/Root', 'import', 'file', 'tsv', '-p', '/Root/test_multiple_files[tsv-additional_args2-row]', '--header', '/home/runner/.ya/build/build_root/g81u/004d80/tmp/test_multiple_files_tsv_additi1/tempinput0.tsv', '/home/runner/.ya/build/build_root/g81u/004d80/tmp/test_multiple_files_tsv_additi1/tempinput1.tsv', '/home/runner/.ya/build/build_root/g81u/004d80/tmp/test_multiple_files_tsv_additi1/tempinput2.tsv', '/home/runner/.ya/build/build_root/g81u/004d80/tmp/test_multiple_files_tsv_additi1/tempinput3.tsv']' in 'None' (waiting)
2025-11-01 04:29:56,201 - DEBUG - ya.test - execute: Command pid: 2900607
2025-11-01 04:29:56,549 - DEBUG - ya.test - _save_outputs: Command (pid 2900607) rc: 0
2025-11-01 04:29:56,550 - DEBUG - ya.test - _save_outputs: Command (pid 2900607) elapsed time (sec): 0.3473548889160156
2025-11-01 04:29:56,550 - DEBUG - ya.test - _save_outputs: Command (pid 2900607) idrss: 0
2025-11-01 04:29:56,550 - DEBUG - ya.test - _save_outputs: Command (pid 2900607) inblock: 0
2025-11-01 04:29:56,550 - DEBUG - ya.test - _save_outputs: Command (pid 2900607) isrss: 0
2025-11-01 04:29:56,551 - DEBUG - ya.test - _save_outputs: Command (pid 2900607) ixrss: 0
2025-11-01 04:29:56,551 - DEBUG - ya.test - _save_outputs: Command (pid 2900607) majflt: 0
2025-11-01 04:29:56,551 - DEBUG - ya.test - _save_outputs: Command (pid 2900607) maxrss: 187756
2025-11-01 04:29:56,551 - DEBUG - ya.test - _save_outputs: Command (pid 2900607) minflt: 4154
2025-11-01 04:29:56,551 - DEBUG - ya.test - _save_outputs: Command (pid 2900607) msgrcv: 0
2025-11-01 04:29:56,552 - DEBUG - ya.test - _save_outputs: Command (pid 2900607) msgsnd: 0
2025-11-01 04:29:56,552 - DEBUG - ya.test - _save_outputs: Command (pid 2900607) nivcsw: 79
2025-11-01 04:29:56,552 - DEBUG - ya.test - _save_outputs: Command (pid 2900607) nsignals: 0
2025-11-01 04:29:56,552 - DEBUG - ya.test - _save_outputs: Command (pid 2900607) nswap: 0
2025-11-01 04:29:56,552 - DEBUG - ya.test - _save_outputs: Command (pid 2900607) nvcsw: 580
2025-11-01 04:29:56,553 - DEBUG - ya.test - _save_outputs: Command (pid 2900607) oublock: 80
2025-11-01 04:29:56,553 - DEBUG - ya.test - _save_outputs: Command (pid 2900607) stime: 0.045028
2025-11-01 04:29:56,553 - DEBUG - ya.test - _save_outputs: Command (pid 2900607) utime: 0.056284999999999995
2025-11-01 04:29:56,553 - DEBUG - ya.test - _save_outputs: Command (pid 2900607) wtime: 0.351
2025-11-01 04:29:56,553 - DEBUG - ya.test - _save_outputs: Command (pid 2900607) output:

2025-11-01 04:29:56,568 - DEBUG - ya.test - _save_outputs: Command (pid 2900607) errors:
Elapsed: 0.044 sec. Total read size: 290B. Average processing speed: 6.44KiB/s.


2025-11-01 04:29:56,573 - DEBUG - __tests__.test_ydb_impex - execute_ydb_cli_command: std_out:

2025-11-01 04:29:56,574 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004d80/ydb/apps/ydb/ydb
2025-11-01 04:29:56,578 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.2
2025-11-01 04:29:56,580 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004d80/ydb/apps/ydb/ydb', '--endpoint', 'grpc://localhost:28853', '--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-11-01 04:29:56,597 - DEBUG - ya.test - execute: Command pid: 2900895
2025-11-01 04:29:56,868 - DEBUG - ya.test - _save_outputs: Command (pid 2900895) rc: 0
2025-11-01 04:29:56,868 - DEBUG - ya.test - _save_outputs: Command (pid 2900895) elapsed time (sec): 0.26422548294067383
2025-11-01 04:29:56,868 - DEBUG - ya.test - _save_outputs: Command (pid 2900895) idrss: 0
2025-11-01 04:29:56,868 - DEBUG - ya.test - _save_outputs: Command (pid 2900895) inblock: 0
2025-11-01 04:29:56,869 - DEBUG - ya.test - _save_outputs: Command (pid 2900895) isrss: 0
2025-11-01 04:29:56,869 - DEBUG - ya.test - _save_outputs: Command (pid 2900895) ixrss: 0
2025-11-01 04:29:56,869 - DEBUG - ya.test - _save_outputs: Command (pid 2900895) majflt: 0
2025-11-01 04:29:56,869 - DEBUG - ya.test - _save_outputs: Command (pid 2900895) maxrss: 187756
2025-11-01 04:29:56,869 - DEBUG - ya.test - _save_outputs: Command (pid 2900895) minflt: 3435
2025-11-01 04:29:56,869 - DEBUG - ya.test - _save_outputs: Command (pid 2900895) msgrcv: 0
2025-11-01 04:29:56,869 - DEBUG - ya.test - _save_outputs: Command (pid 2900895) msgsnd: 0
2025-11-01 04:29:56,870 - DEBUG - ya.test - _save_outputs: Command (pid 2900895) nivcsw: 31
2025-11-01 04:29:56,884 - DEBUG - ya.test - _save_outputs: Command (pid 2900895) nsignals: 0
2025-11-01 04:29:56,884 - DEBUG - ya.test - _save_outputs: Command (pid 2900895) nswap: 0
2025-11-01 04:29:56,884 - DEBUG - ya.test - _save_outputs: Command (pid 2900895) nvcsw: 134
2025-11-01 04:29:56,885 - DEBUG - ya.test - _save_outputs: Command (pid 2900895) oublock: 8
2025-11-01 04:29:56,885 - DEBUG - ya.test - _save_outputs: Command (pid 2900895) stime: 0.011106
2025-11-01 04:29:56,885 - DEBUG - ya.test - _save_outputs: Command (pid 2900895) utime: 0.066637
2025-11-01 04:29:56,885 - DEBUG - ya.test - _save_outputs: Command (pid 2900895) wtime: 0.287
2025-11-01 04:29:56,885 - DEBUG - ya.test - _save_outputs: Command (pid 2900895) 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:29:56,886 - DEBUG - ya.test - _save_outputs: Command (pid 2900895) errors:

2025-11-01 04:29:56,886 - 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:29:56,892 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-11-01 04:30:20,980 - 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-11-01 04:30:20,994 - DEBUG - ya.test - verify: Test test_ydb_impex.TestImpex.test_multiple_files[tsv-additional_args2-row] status: good
