2025-11-01 04:20:22,701 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 04:20:22,701 - INFO - ya.test - pytest_runtest_setup: test_multiple_files_and_columns_opt[tsv-additional_args3-column]
2025-11-01 04:20:22,701 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 04:20:22,701 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-01 04:20:22,704 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_ydb_impex.py::TestImpex, test_name: test_multiple_files_and_columns_opt[tsv-additional_args3-column])
2025-11-01 04:20:22,704 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, 3309c0aa-25d4-41a9-8dce-2c872da182f5, ghrun-i4gyxlpqdu.auto.internal:10984): creating call state
2025-11-01 04:20:22,705 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, 3309c0aa-25d4-41a9-8dce-2c872da182f5, ghrun-i4gyxlpqdu.auto.internal:10984): request = { session_id: "ydb://session/3?node_id=1&id=NjhmOWYwOGMtZjRiOWFmZjMtZjg2NGYxOWEtNTA4YTIwZjM=" yql_text: "\n        CREATE TABLE `/Root/test_multiple_files_and_columns_opt[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:22,943 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, 3309c0aa-25d4-41a9-8dce-2c872da182f5, ghrun-i4gyxlpqdu.auto.internal:10984): response = { operation { ready: true status: SUCCESS } }
2025-11-01 04:20:22,945 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004de3/ydb/apps/ydb/ydb
2025-11-01 04:20:22,945 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.0
2025-11-01 04:20:22,946 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.1
2025-11-01 04:20:22,946 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004de3/ydb/apps/ydb/ydb', '--endpoint', 'grpc://localhost:10984', '--database', '/Root', 'import', 'file', 'tsv', '-p', '/Root/test_multiple_files_and_columns_opt[tsv-additional_args3-column]', '--header', '--columns', 'key\tid\tvalue\n', '--newline-delimited', '/home/runner/.ya/build/build_root/g81u/004de3/tmp/test_multiple_files_and_column1/tempinput0.tsv', '/home/runner/.ya/build/build_root/g81u/004de3/tmp/test_multiple_files_and_column1/tempinput1.tsv', '/home/runner/.ya/build/build_root/g81u/004de3/tmp/test_multiple_files_and_column1/tempinput2.tsv', '/home/runner/.ya/build/build_root/g81u/004de3/tmp/test_multiple_files_and_column1/tempinput3.tsv']' in 'None' (waiting)
2025-11-01 04:20:22,947 - DEBUG - ya.test - execute: Command pid: 2555204
2025-11-01 04:20:23,091 - DEBUG - ya.test - _save_outputs: Command (pid 2555204) rc: 0
2025-11-01 04:20:23,092 - DEBUG - ya.test - _save_outputs: Command (pid 2555204) elapsed time (sec): 0.1440448760986328
2025-11-01 04:20:23,092 - DEBUG - ya.test - _save_outputs: Command (pid 2555204) idrss: 0
2025-11-01 04:20:23,092 - DEBUG - ya.test - _save_outputs: Command (pid 2555204) inblock: 0
2025-11-01 04:20:23,092 - DEBUG - ya.test - _save_outputs: Command (pid 2555204) isrss: 0
2025-11-01 04:20:23,092 - DEBUG - ya.test - _save_outputs: Command (pid 2555204) ixrss: 0
2025-11-01 04:20:23,092 - DEBUG - ya.test - _save_outputs: Command (pid 2555204) majflt: 0
2025-11-01 04:20:23,092 - DEBUG - ya.test - _save_outputs: Command (pid 2555204) maxrss: 184472
2025-11-01 04:20:23,093 - DEBUG - ya.test - _save_outputs: Command (pid 2555204) minflt: 4423
2025-11-01 04:20:23,093 - DEBUG - ya.test - _save_outputs: Command (pid 2555204) msgrcv: 0
2025-11-01 04:20:23,093 - DEBUG - ya.test - _save_outputs: Command (pid 2555204) msgsnd: 0
2025-11-01 04:20:23,093 - DEBUG - ya.test - _save_outputs: Command (pid 2555204) nivcsw: 0
2025-11-01 04:20:23,093 - DEBUG - ya.test - _save_outputs: Command (pid 2555204) nsignals: 0
2025-11-01 04:20:23,093 - DEBUG - ya.test - _save_outputs: Command (pid 2555204) nswap: 0
2025-11-01 04:20:23,093 - DEBUG - ya.test - _save_outputs: Command (pid 2555204) nvcsw: 944
2025-11-01 04:20:23,093 - DEBUG - ya.test - _save_outputs: Command (pid 2555204) oublock: 48
2025-11-01 04:20:23,093 - DEBUG - ya.test - _save_outputs: Command (pid 2555204) stime: 0.054738999999999996
2025-11-01 04:20:23,093 - DEBUG - ya.test - _save_outputs: Command (pid 2555204) utime: 0.041056999999999996
2025-11-01 04:20:23,094 - DEBUG - ya.test - _save_outputs: Command (pid 2555204) wtime: 0.145
2025-11-01 04:20:23,094 - DEBUG - ya.test - _save_outputs: Command (pid 2555204) output:

2025-11-01 04:20:23,094 - DEBUG - ya.test - _save_outputs: Command (pid 2555204) errors:
Elapsed: 0.0181 sec. Total read size: 290B. Average processing speed: 15.7KiB/s.


2025-11-01 04:20:23,094 - DEBUG - __tests__.test_ydb_impex - execute_ydb_cli_command: std_out:

2025-11-01 04:20:23,094 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004de3/ydb/apps/ydb/ydb
2025-11-01 04:20:23,095 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.2
2025-11-01 04:20:23,095 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004de3/ydb/apps/ydb/ydb', '--endpoint', 'grpc://localhost:10984', '--database', '/Root', 'table', 'query', 'execute', '-q', 'SELECT `key`, `id`, `value` FROM `/Root/test_multiple_files_and_columns_opt[tsv-additional_args3-column]` ORDER BY `key`', '-t', 'scan', '--format', 'tsv']' in 'None' (waiting)
2025-11-01 04:20:23,096 - DEBUG - ya.test - execute: Command pid: 2555518
2025-11-01 04:20:23,257 - DEBUG - ya.test - _save_outputs: Command (pid 2555518) rc: 0
2025-11-01 04:20:23,258 - DEBUG - ya.test - _save_outputs: Command (pid 2555518) elapsed time (sec): 0.16077208518981934
2025-11-01 04:20:23,258 - DEBUG - ya.test - _save_outputs: Command (pid 2555518) idrss: 0
2025-11-01 04:20:23,258 - DEBUG - ya.test - _save_outputs: Command (pid 2555518) inblock: 0
2025-11-01 04:20:23,259 - DEBUG - ya.test - _save_outputs: Command (pid 2555518) isrss: 0
2025-11-01 04:20:23,259 - DEBUG - ya.test - _save_outputs: Command (pid 2555518) ixrss: 0
2025-11-01 04:20:23,259 - DEBUG - ya.test - _save_outputs: Command (pid 2555518) majflt: 0
2025-11-01 04:20:23,259 - DEBUG - ya.test - _save_outputs: Command (pid 2555518) maxrss: 184472
2025-11-01 04:20:23,259 - DEBUG - ya.test - _save_outputs: Command (pid 2555518) minflt: 3439
2025-11-01 04:20:23,260 - DEBUG - ya.test - _save_outputs: Command (pid 2555518) msgrcv: 0
2025-11-01 04:20:23,260 - DEBUG - ya.test - _save_outputs: Command (pid 2555518) msgsnd: 0
2025-11-01 04:20:23,260 - DEBUG - ya.test - _save_outputs: Command (pid 2555518) nivcsw: 0
2025-11-01 04:20:23,260 - DEBUG - ya.test - _save_outputs: Command (pid 2555518) nsignals: 0
2025-11-01 04:20:23,260 - DEBUG - ya.test - _save_outputs: Command (pid 2555518) nswap: 0
2025-11-01 04:20:23,261 - DEBUG - ya.test - _save_outputs: Command (pid 2555518) nvcsw: 190
2025-11-01 04:20:23,261 - DEBUG - ya.test - _save_outputs: Command (pid 2555518) oublock: 8
2025-11-01 04:20:23,261 - DEBUG - ya.test - _save_outputs: Command (pid 2555518) stime: 0.022137
2025-11-01 04:20:23,261 - DEBUG - ya.test - _save_outputs: Command (pid 2555518) utime: 0.03542
2025-11-01 04:20:23,261 - DEBUG - ya.test - _save_outputs: Command (pid 2555518) wtime: 0.162
2025-11-01 04:20:23,261 - DEBUG - ya.test - _save_outputs: Command (pid 2555518) 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:23,262 - DEBUG - ya.test - _save_outputs: Command (pid 2555518) errors:

2025-11-01 04:20:23,262 - 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:23,264 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-11-01 04:20:46,124 - DEBUG - ya.test - _verify_test: Verifying [test_ydb_impex.TestImpex.test_multiple_files_and_columns_opt[tsv-additional_args3-column] in ydb/tests/functional/ydb_cli] canonical results
2025-11-01 04:20:46,125 - DEBUG - ya.test - verify: Test test_ydb_impex.TestImpex.test_multiple_files_and_columns_opt[tsv-additional_args3-column] status: good
