2025-11-01 20:01:28,243 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 20:01:28,243 - INFO - ya.test - pytest_runtest_setup: test_log_uniform
2025-11-01 20:01:28,244 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 20:01:28,244 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-01 20:01:28,245 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_log_scenario.py::TestLogScenario, test_name: test_log_uniform)
2025-11-01 20:01:28,245 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/vv82/002f47/ydb/apps/ydb/ydb
2025-11-01 20:01:28,246 - INFO - root - _call: YdbWorkloadLog execute /home/runner/.ya/build/build_root/vv82/002f47/ydb/apps/ydb/ydb -e grpc://localhost:64916 -d /Root workload log --path log init --path log --store column --ttl 1000 with wait = True
2025-11-01 20:01:28,247 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.11
2025-11-01 20:01:28,247 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.11
2025-11-01 20:01:28,248 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/vv82/002f47/ydb/apps/ydb/ydb', '-e', 'grpc://localhost:64916', '-d', '/Root', 'workload', 'log', '--path', 'log', 'init', '--path', 'log', '--store', 'column', '--ttl', '1000']' in 'None' (waiting)
2025-11-01 20:01:28,254 - DEBUG - ya.test - execute: Command pid: 3350784
2025-11-01 20:01:29,090 - DEBUG - ya.test - _save_outputs: Command (pid 3350784) rc: 0
2025-11-01 20:01:29,096 - DEBUG - ya.test - _save_outputs: Command (pid 3350784) elapsed time (sec): 0.7433629035949707
2025-11-01 20:01:29,097 - DEBUG - ya.test - _save_outputs: Command (pid 3350784) idrss: 0
2025-11-01 20:01:29,097 - DEBUG - ya.test - _save_outputs: Command (pid 3350784) inblock: 0
2025-11-01 20:01:29,116 - DEBUG - ya.test - _save_outputs: Command (pid 3350784) isrss: 0
2025-11-01 20:01:29,116 - DEBUG - ya.test - _save_outputs: Command (pid 3350784) ixrss: 0
2025-11-01 20:01:29,116 - DEBUG - ya.test - _save_outputs: Command (pid 3350784) majflt: 0
2025-11-01 20:01:29,116 - DEBUG - ya.test - _save_outputs: Command (pid 3350784) maxrss: 717124
2025-11-01 20:01:29,117 - DEBUG - ya.test - _save_outputs: Command (pid 3350784) minflt: 3546
2025-11-01 20:01:29,117 - DEBUG - ya.test - _save_outputs: Command (pid 3350784) msgrcv: 0
2025-11-01 20:01:29,117 - DEBUG - ya.test - _save_outputs: Command (pid 3350784) msgsnd: 0
2025-11-01 20:01:29,117 - DEBUG - ya.test - _save_outputs: Command (pid 3350784) nivcsw: 38
2025-11-01 20:01:29,117 - DEBUG - ya.test - _save_outputs: Command (pid 3350784) nsignals: 0
2025-11-01 20:01:29,117 - DEBUG - ya.test - _save_outputs: Command (pid 3350784) nswap: 0
2025-11-01 20:01:29,118 - DEBUG - ya.test - _save_outputs: Command (pid 3350784) nvcsw: 150
2025-11-01 20:01:29,118 - DEBUG - ya.test - _save_outputs: Command (pid 3350784) oublock: 8
2025-11-01 20:01:29,118 - DEBUG - ya.test - _save_outputs: Command (pid 3350784) stime: 0.021755
2025-11-01 20:01:29,118 - DEBUG - ya.test - _save_outputs: Command (pid 3350784) utime: 0.070906
2025-11-01 20:01:29,118 - DEBUG - ya.test - _save_outputs: Command (pid 3350784) wtime: 0.802
2025-11-01 20:01:29,119 - DEBUG - ya.test - _save_outputs: Command (pid 3350784) output:
Init tables ...
Init tables ...Ok

2025-11-01 20:01:29,119 - DEBUG - ya.test - _save_outputs: Command (pid 3350784) errors:

2025-11-01 20:01:29,119 - INFO - root - _insert_rows: YdbWorkloadLog bulk_upsert
2025-11-01 20:01:29,119 - INFO - root - _call: YdbWorkloadLog execute /home/runner/.ya/build/build_root/vv82/002f47/ydb/apps/ydb/ydb -e grpc://localhost:64916 -d /Root workload log --path log run bulk_upsert --seconds 30 --threads 10 --rows 1 --date-from 0 --date-to 2678400000 with wait = True
2025-11-01 20:01:29,129 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.12
2025-11-01 20:01:29,133 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.12
2025-11-01 20:01:29,148 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/vv82/002f47/ydb/apps/ydb/ydb', '-e', 'grpc://localhost:64916', '-d', '/Root', 'workload', 'log', '--path', 'log', 'run', 'bulk_upsert', '--seconds', '30', '--threads', '10', '--rows', '1', '--date-from', '0', '--date-to', '2678400000']' in 'None' (waiting)
2025-11-01 20:01:29,152 - DEBUG - ya.test - execute: Command pid: 3351263
2025-11-01 20:01:37,116 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:01:37,116 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:01:37,123 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-01 20:01:37,124 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 7da3774f-ce33-49b2-90cc-c6f518c61704, localhost:64916): creating call state
2025-11-01 20:01:37,124 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 7da3774f-ce33-49b2-90cc-c6f518c61704, localhost:64916): request = { database: "/Root" }
2025-11-01 20:01:37,128 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 7da3774f-ce33-49b2-90cc-c6f518c61704, localhost:64916): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-mjpjznvske.auto.internal" port: 64916 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-11-01 20:01:37,140 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-mjpjznvske.auto.internal:64916, location 1, ssl: False>]>
2025-11-01 20:01:37,141 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:64916
2025-11-01 20:01:59,420 - DEBUG - ya.test - _wait: Process resource usage is not available as process finished before wait4 was called
2025-11-01 20:01:59,420 - DEBUG - ya.test - _save_outputs: Command (pid 3351263) rc: 0
2025-11-01 20:01:59,420 - DEBUG - ya.test - _save_outputs: Command (pid 3351263) elapsed time (sec): 30.224057912826538
2025-11-01 20:01:59,421 - DEBUG - ya.test - _save_outputs: Command (pid 3351263) wtime: 30.272
2025-11-01 20:01:59,421 - DEBUG - ya.test - _save_outputs: Command (pid 3351263) output:
Window	    Txs	Txs/Sec	Retries	Errors	p50(ms)	p95(ms)	p99(ms)	pMax(ms)
1	    265	265	0	0	32	66	91	100
2	    308	308	0	0	31	47	62	81
3	    357	357	0	0	26	46	53	59
4	    393	393	0	0	23	44	56	59
5	    377	377	0	0	24	44	62	70
6	    423	423	0	0	22	39	55	58
7	    381	381	0	0	24	47	57	61
8	    403	403	0	0	22	42	57	60
9	    275	275	0	0	31	79	93	99
10	    342	342	0	0	26	50	66	71
11	    451	451	0	0	20	37	46	51
12	    412	412	0	0	20	43	50	63
13	    356	356	0	0	23	56	68	71
14	    405	405	0	0	23	40	47	55
15	    401	401	0	0	22	45	51	55
16	    379	379	0	0	24	42	49	59
17	    444	444	0	0	20	38	66	71
18	    500	500	0	0	17	38	50	56
19	    425	425	0	0	20	47	80	85
20	    526	526	0	0	17	33	38	43
21	    364	364	0	0	27	44	55	62
22	    401	401	0	0	22	44	53	61
23	    461	461	0	0	20	35	49	59
24	    543	543	0	0	16	33	46	66
25	    491	491	0	0	19	32	53	58
26	    547	547	0	0	17	28	35	38
27	    458	458	0	0	19	43	50	54
28	    497	497	0	0	18	36	48	53
29	    487	487	0	0	18	36	44	48
30	    641	641	0	0	14	27	34	40

Total	    Txs	Txs/Sec	Retries	Errors	p50(ms)	p95(ms)	p99(ms)	pMax(ms)
30	  12713	423.767	0	0	20	43	59	100

2025-11-01 20:01:59,421 - DEBUG - ya.test - _save_outputs: Command (pid 3351263) errors:

2025-11-01 20:01:59,422 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTNjM2M0NDktYWE3NGRmMzMtM2QwZWUtYTg4ZWFiN2E=
2025-11-01 20:01:59,422 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e0afb934-3e55-4cc7-b367-e9a01bce5e48, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:01:59,422 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e0afb934-3e55-4cc7-b367-e9a01bce5e48, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=MTNjM2M0NDktYWE3NGRmMzMtM2QwZWUtYTg4ZWFiN2E=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select count(*) as Rows from `log`" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:01:59,423 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e0afb934-3e55-4cc7-b367-e9a01bce5e48, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:01:59,793 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MTNjM2M0NDktYWE3NGRmMzMtM2QwZWUtYTg4ZWFiN2E=
2025-11-01 20:01:59,802 - INFO - root - test_log_uniform: Count rows after insert 12487 before wait
2025-11-01 20:01:59,802 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmFiZjcxYWQtNzI0ZmMzZmMtZDEzZDhmMTEtOTU4ODg4NmQ=
2025-11-01 20:01:59,803 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 783426cc-f934-4ee9-8a81-daa595db5fc9, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:01:59,803 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 783426cc-f934-4ee9-8a81-daa595db5fc9, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=MmFiZjcxYWQtNzI0ZmMzZmMtZDEzZDhmMTEtOTU4ODg4NmQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select count(*) as Rows from `log`" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:01:59,804 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 783426cc-f934-4ee9-8a81-daa595db5fc9, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:00,015 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MmFiZjcxYWQtNzI0ZmMzZmMtZDEzZDhmMTEtOTU4ODg4NmQ=
2025-11-01 20:02:00,015 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2VhZTVhMmYtYjcxMjM0NWEtYWNlNDAzMWQtNWI3ODEzODQ=
2025-11-01 20:02:00,016 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1675a806-8ad0-4206-b81e-58d1eb3913c8, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:00,016 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1675a806-8ad0-4206-b81e-58d1eb3913c8, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=N2VhZTVhMmYtYjcxMjM0NWEtYWNlNDAzMWQtNWI3ODEzODQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select count(*) as Rows from `log`" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:00,017 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1675a806-8ad0-4206-b81e-58d1eb3913c8, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:00,231 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2VhZTVhMmYtYjcxMjM0NWEtYWNlNDAzMWQtNWI3ODEzODQ=
2025-11-01 20:02:00,232 - INFO - root - _insert_rows: YdbWorkloadLog bulk_upsert
2025-11-01 20:02:00,233 - INFO - root - _insert_rows: YdbWorkloadLog insert
2025-11-01 20:02:00,233 - INFO - root - _insert_rows: YdbWorkloadLog upsert
2025-11-01 20:02:00,234 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVjNDBkY2QtYzU0MWU3ZDYtY2E2YzI5MTMtZmYzY2JjYzM=
2025-11-01 20:02:00,236 - INFO - root - _call: YdbWorkloadLog execute /home/runner/.ya/build/build_root/vv82/002f47/ydb/apps/ydb/ydb -e grpc://localhost:64916 -d /Root workload log --path log run bulk_upsert --seconds 30 --threads 10 --rows 1 --date-from 0 --date-to 2678400000 with wait = True
2025-11-01 20:02:00,237 - INFO - root - _call: YdbWorkloadLog execute /home/runner/.ya/build/build_root/vv82/002f47/ydb/apps/ydb/ydb -e grpc://localhost:64916 -d /Root workload log --path log run insert --seconds 30 --threads 10 --rows 1 --date-from 0 --date-to 2678400000 with wait = True
2025-11-01 20:02:00,237 - INFO - root - _call: YdbWorkloadLog execute /home/runner/.ya/build/build_root/vv82/002f47/ydb/apps/ydb/ydb -e grpc://localhost:64916 -d /Root workload log --path log run upsert --seconds 30 --threads 10 --rows 1 --date-from 0 --date-to 2678400000 with wait = True
2025-11-01 20:02:00,244 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b5299797-6f10-4572-b36d-84e4eb4384fb, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:00,245 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2FmMTljM2QtYjM5ZDY2MjUtMmVmMmE3ZjgtZjliN2EzZTc=
2025-11-01 20:02:00,250 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f6effaa0-3962-4199-add2-3ed3e0f0e00c, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:00,248 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.14
2025-11-01 20:02:00,250 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b5299797-6f10-4572-b36d-84e4eb4384fb, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=NzVjNDBkY2QtYzU0MWU3ZDYtY2E2YzI5MTMtZmYzY2JjYzM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:00,248 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.13
2025-11-01 20:02:00,251 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYwODM1YWItOWE5Y2RhYjYtNzZlN2IyNTQtOTQzNjhiNWY=
2025-11-01 20:02:00,251 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f6effaa0-3962-4199-add2-3ed3e0f0e00c, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=M2FmMTljM2QtYjM5ZDY2MjUtMmVmMmE3ZjgtZjliN2EzZTc=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:00,252 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.15
2025-11-01 20:02:00,255 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.13
2025-11-01 20:02:00,257 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 53cbc809-3197-455c-b655-2d3548eaae6c, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:00,258 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZGEwOGY3ZWEtNWZmOGRlM2EtY2U3N2E5ZjQtZDFlZjQwMA==
2025-11-01 20:02:00,258 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b5299797-6f10-4572-b36d-84e4eb4384fb, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:00,261 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.14
2025-11-01 20:02:00,262 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f6effaa0-3962-4199-add2-3ed3e0f0e00c, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:00,267 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 53cbc809-3197-455c-b655-2d3548eaae6c, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=ZWYwODM1YWItOWE5Y2RhYjYtNzZlN2IyNTQtOTQzNjhiNWY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:00,272 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 27274eed-7976-4148-a317-e6131ab87a32, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:00,276 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.15
2025-11-01 20:02:00,286 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 27274eed-7976-4148-a317-e6131ab87a32, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=ZGEwOGY3ZWEtNWZmOGRlM2EtY2U3N2E5ZjQtZDFlZjQwMA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:00,287 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 53cbc809-3197-455c-b655-2d3548eaae6c, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:00,287 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/vv82/002f47/ydb/apps/ydb/ydb', '-e', 'grpc://localhost:64916', '-d', '/Root', 'workload', 'log', '--path', 'log', 'run', 'bulk_upsert', '--seconds', '30', '--threads', '10', '--rows', '1', '--date-from', '0', '--date-to', '2678400000']' in 'None' (waiting)
2025-11-01 20:02:00,289 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 27274eed-7976-4148-a317-e6131ab87a32, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:00,279 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/vv82/002f47/ydb/apps/ydb/ydb', '-e', 'grpc://localhost:64916', '-d', '/Root', 'workload', 'log', '--path', 'log', 'run', 'insert', '--seconds', '30', '--threads', '10', '--rows', '1', '--date-from', '0', '--date-to', '2678400000']' in 'None' (waiting)
2025-11-01 20:02:00,280 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZjA5Mjc3MzctYzE1MTA4ZDEtMjdiMGM5MzktMjAzYmY2YTY=
2025-11-01 20:02:00,308 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4b98673e-5a17-4c47-b2b0-380c4053e6e9, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:00,308 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4b98673e-5a17-4c47-b2b0-380c4053e6e9, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=ZjA5Mjc3MzctYzE1MTA4ZDEtMjdiMGM5MzktMjAzYmY2YTY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:00,309 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4b98673e-5a17-4c47-b2b0-380c4053e6e9, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:00,310 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NTRhNWE5MjAtYjNkNGIwZjItMzZiOGY5NjctOTlkYWQ2NGQ=
2025-11-01 20:02:00,310 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e8e6820a-f9c1-4b50-983c-33b9592293ed, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:00,311 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e8e6820a-f9c1-4b50-983c-33b9592293ed, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=NTRhNWE5MjAtYjNkNGIwZjItMzZiOGY5NjctOTlkYWQ2NGQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:00,311 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e8e6820a-f9c1-4b50-983c-33b9592293ed, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:00,312 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDZiYjk5MGUtZTM2M2YzYTItNTRlMTY0MzYtN2U2NDhiYTk=
2025-11-01 20:02:00,312 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 52f27d66-aa97-4043-9b77-73dbcf2f160d, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:00,313 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 52f27d66-aa97-4043-9b77-73dbcf2f160d, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=NDZiYjk5MGUtZTM2M2YzYTItNTRlMTY0MzYtN2U2NDhiYTk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:00,313 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 52f27d66-aa97-4043-9b77-73dbcf2f160d, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:00,314 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTNjM2M0NDktYWE3NGRmMzMtM2QwZWUtYTg4ZWFiN2E=
2025-11-01 20:02:00,314 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b70db9c0-a55a-4bd2-a44d-597ded201072, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:00,315 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b70db9c0-a55a-4bd2-a44d-597ded201072, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=MTNjM2M0NDktYWE3NGRmMzMtM2QwZWUtYTg4ZWFiN2E=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:00,315 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b70db9c0-a55a-4bd2-a44d-597ded201072, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:00,316 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmFiZjcxYWQtNzI0ZmMzZmMtZDEzZDhmMTEtOTU4ODg4NmQ=
2025-11-01 20:02:00,316 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1d83941c-5386-4e84-86e4-55f6b931568d, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:00,292 - DEBUG - ya.test - execute: Command pid: 3372513
2025-11-01 20:02:00,301 - DEBUG - ya.test - execute: Command pid: 3372516
2025-11-01 20:02:00,296 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/vv82/002f47/ydb/apps/ydb/ydb', '-e', 'grpc://localhost:64916', '-d', '/Root', 'workload', 'log', '--path', 'log', 'run', 'upsert', '--seconds', '30', '--threads', '10', '--rows', '1', '--date-from', '0', '--date-to', '2678400000']' in 'None' (waiting)
2025-11-01 20:02:00,317 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2VhZTVhMmYtYjcxMjM0NWEtYWNlNDAzMWQtNWI3ODEzODQ=
2025-11-01 20:02:00,320 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1d83941c-5386-4e84-86e4-55f6b931568d, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=MmFiZjcxYWQtNzI0ZmMzZmMtZDEzZDhmMTEtOTU4ODg4NmQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:00,326 - DEBUG - ya.test - execute: Command pid: 3372635
2025-11-01 20:02:00,331 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5721d9cd-82bb-49c4-993b-c1abe62f5fdd, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:00,339 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1d83941c-5386-4e84-86e4-55f6b931568d, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:00,340 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5721d9cd-82bb-49c4-993b-c1abe62f5fdd, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=N2VhZTVhMmYtYjcxMjM0NWEtYWNlNDAzMWQtNWI3ODEzODQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:00,342 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5721d9cd-82bb-49c4-993b-c1abe62f5fdd, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:03,463 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NTRhNWE5MjAtYjNkNGIwZjItMzZiOGY5NjctOTlkYWQ2NGQ=
2025-11-01 20:02:03,493 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NTRhNWE5MjAtYjNkNGIwZjItMzZiOGY5NjctOTlkYWQ2NGQ=
2025-11-01 20:02:03,494 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cef235a2-857b-4a34-bf78-a46252dca2d7, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:03,521 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cef235a2-857b-4a34-bf78-a46252dca2d7, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=NTRhNWE5MjAtYjNkNGIwZjItMzZiOGY5NjctOTlkYWQ2NGQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(2)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:03,522 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cef235a2-857b-4a34-bf78-a46252dca2d7, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:03,483 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVjNDBkY2QtYzU0MWU3ZDYtY2E2YzI5MTMtZmYzY2JjYzM=
2025-11-01 20:02:03,541 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZGEwOGY3ZWEtNWZmOGRlM2EtY2U3N2E5ZjQtZDFlZjQwMA==
2025-11-01 20:02:03,546 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 155e3f05-290f-4ab1-b5d8-89b290049b66, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:03,502 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2VhZTVhMmYtYjcxMjM0NWEtYWNlNDAzMWQtNWI3ODEzODQ=
2025-11-01 20:02:03,472 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZGEwOGY3ZWEtNWZmOGRlM2EtY2U3N2E5ZjQtZDFlZjQwMA==
2025-11-01 20:02:03,504 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MTNjM2M0NDktYWE3NGRmMzMtM2QwZWUtYTg4ZWFiN2E=
2025-11-01 20:02:03,516 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYwODM1YWItOWE5Y2RhYjYtNzZlN2IyNTQtOTQzNjhiNWY=
2025-11-01 20:02:03,483 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZjA5Mjc3MzctYzE1MTA4ZDEtMjdiMGM5MzktMjAzYmY2YTY=
2025-11-01 20:02:03,480 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=M2FmMTljM2QtYjM5ZDY2MjUtMmVmMmE3ZjgtZjliN2EzZTc=
2025-11-01 20:02:03,480 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MmFiZjcxYWQtNzI0ZmMzZmMtZDEzZDhmMTEtOTU4ODg4NmQ=
2025-11-01 20:02:03,547 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 155e3f05-290f-4ab1-b5d8-89b290049b66, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=ZGEwOGY3ZWEtNWZmOGRlM2EtY2U3N2E5ZjQtZDFlZjQwMA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(4)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:03,585 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 155e3f05-290f-4ab1-b5d8-89b290049b66, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:03,504 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDZiYjk5MGUtZTM2M2YzYTItNTRlMTY0MzYtN2U2NDhiYTk=
2025-11-01 20:02:03,548 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmFiZjcxYWQtNzI0ZmMzZmMtZDEzZDhmMTEtOTU4ODg4NmQ=
2025-11-01 20:02:03,589 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9ff1a68c-8c79-4249-b884-423be1ca13ad, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:03,589 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2FmMTljM2QtYjM5ZDY2MjUtMmVmMmE3ZjgtZjliN2EzZTc=
2025-11-01 20:02:03,590 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9ff1a68c-8c79-4249-b884-423be1ca13ad, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=MmFiZjcxYWQtNzI0ZmMzZmMtZDEzZDhmMTEtOTU4ODg4NmQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(9)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:03,615 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4653559b-e165-41d2-85b4-fb8bb6a54925, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:03,624 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9ff1a68c-8c79-4249-b884-423be1ca13ad, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:03,620 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZjA5Mjc3MzctYzE1MTA4ZDEtMjdiMGM5MzktMjAzYmY2YTY=
2025-11-01 20:02:03,654 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 63537900-1aec-46d1-8b63-a82acb2907ba, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:03,654 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 63537900-1aec-46d1-8b63-a82acb2907ba, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=ZjA5Mjc3MzctYzE1MTA4ZDEtMjdiMGM5MzktMjAzYmY2YTY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(8)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:03,655 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 63537900-1aec-46d1-8b63-a82acb2907ba, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:03,652 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4653559b-e165-41d2-85b4-fb8bb6a54925, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=M2FmMTljM2QtYjM5ZDY2MjUtMmVmMmE3ZjgtZjliN2EzZTc=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(6)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:03,665 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4653559b-e165-41d2-85b4-fb8bb6a54925, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:03,662 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVjNDBkY2QtYzU0MWU3ZDYtY2E2YzI5MTMtZmYzY2JjYzM=
2025-11-01 20:02:03,666 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f326a6d8-ae17-4206-ac3e-906562c15bc5, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:03,666 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f326a6d8-ae17-4206-ac3e-906562c15bc5, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=NzVjNDBkY2QtYzU0MWU3ZDYtY2E2YzI5MTMtZmYzY2JjYzM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(5)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:03,668 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f326a6d8-ae17-4206-ac3e-906562c15bc5, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:03,668 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2VhZTVhMmYtYjcxMjM0NWEtYWNlNDAzMWQtNWI3ODEzODQ=
2025-11-01 20:02:03,709 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 306c72d9-261e-4ccc-871c-b346075211d3, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:03,710 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 306c72d9-261e-4ccc-871c-b346075211d3, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=N2VhZTVhMmYtYjcxMjM0NWEtYWNlNDAzMWQtNWI3ODEzODQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(9)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:03,711 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 306c72d9-261e-4ccc-871c-b346075211d3, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:03,711 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDZiYjk5MGUtZTM2M2YzYTItNTRlMTY0MzYtN2U2NDhiYTk=
2025-11-01 20:02:03,742 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, bb9af963-435f-47f7-882b-8a69df62e1f4, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:03,747 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, bb9af963-435f-47f7-882b-8a69df62e1f4, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=NDZiYjk5MGUtZTM2M2YzYTItNTRlMTY0MzYtN2U2NDhiYTk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(10)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:03,748 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, bb9af963-435f-47f7-882b-8a69df62e1f4, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:03,742 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTNjM2M0NDktYWE3NGRmMzMtM2QwZWUtYTg4ZWFiN2E=
2025-11-01 20:02:03,757 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b406ee62-b393-4d26-bcd7-394487fcbea5, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:03,758 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b406ee62-b393-4d26-bcd7-394487fcbea5, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=MTNjM2M0NDktYWE3NGRmMzMtM2QwZWUtYTg4ZWFiN2E=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(2)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:03,758 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b406ee62-b393-4d26-bcd7-394487fcbea5, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:03,760 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYwODM1YWItOWE5Y2RhYjYtNzZlN2IyNTQtOTQzNjhiNWY=
2025-11-01 20:02:03,768 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4e307a52-5466-40bc-892e-c90ef001525b, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:03,769 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4e307a52-5466-40bc-892e-c90ef001525b, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=ZWYwODM1YWItOWE5Y2RhYjYtNzZlN2IyNTQtOTQzNjhiNWY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(4)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:03,769 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4e307a52-5466-40bc-892e-c90ef001525b, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:17,402 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDZiYjk5MGUtZTM2M2YzYTItNTRlMTY0MzYtN2U2NDhiYTk=
2025-11-01 20:02:17,591 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDZiYjk5MGUtZTM2M2YzYTItNTRlMTY0MzYtN2U2NDhiYTk=
2025-11-01 20:02:17,651 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 64a36bfb-a6f8-4135-bea1-c97fba97e9a8, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:17,674 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 64a36bfb-a6f8-4135-bea1-c97fba97e9a8, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=NDZiYjk5MGUtZTM2M2YzYTItNTRlMTY0MzYtN2U2NDhiYTk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(10)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:17,680 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZjA5Mjc3MzctYzE1MTA4ZDEtMjdiMGM5MzktMjAzYmY2YTY=
2025-11-01 20:02:17,708 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 64a36bfb-a6f8-4135-bea1-c97fba97e9a8, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:17,916 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZjA5Mjc3MzctYzE1MTA4ZDEtMjdiMGM5MzktMjAzYmY2YTY=
2025-11-01 20:02:17,954 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4cfdfcaf-ac1b-4ac2-a98c-01a65a60426f, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:18,041 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4cfdfcaf-ac1b-4ac2-a98c-01a65a60426f, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=ZjA5Mjc3MzctYzE1MTA4ZDEtMjdiMGM5MzktMjAzYmY2YTY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(8)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:18,052 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4cfdfcaf-ac1b-4ac2-a98c-01a65a60426f, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:18,126 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2VhZTVhMmYtYjcxMjM0NWEtYWNlNDAzMWQtNWI3ODEzODQ=
2025-11-01 20:02:18,399 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2VhZTVhMmYtYjcxMjM0NWEtYWNlNDAzMWQtNWI3ODEzODQ=
2025-11-01 20:02:18,424 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 77515b9a-3df0-4612-86a9-78719130a5f4, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:18,425 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 77515b9a-3df0-4612-86a9-78719130a5f4, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=N2VhZTVhMmYtYjcxMjM0NWEtYWNlNDAzMWQtNWI3ODEzODQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(9)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:18,434 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NTRhNWE5MjAtYjNkNGIwZjItMzZiOGY5NjctOTlkYWQ2NGQ=
2025-11-01 20:02:18,585 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NTRhNWE5MjAtYjNkNGIwZjItMzZiOGY5NjctOTlkYWQ2NGQ=
2025-11-01 20:02:18,590 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 77515b9a-3df0-4612-86a9-78719130a5f4, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:18,620 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cfc1be79-ed1c-4ff3-bbe4-d3c7cf5c22b9, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:18,636 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cfc1be79-ed1c-4ff3-bbe4-d3c7cf5c22b9, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=NTRhNWE5MjAtYjNkNGIwZjItMzZiOGY5NjctOTlkYWQ2NGQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(2)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:18,636 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDZiYjk5MGUtZTM2M2YzYTItNTRlMTY0MzYtN2U2NDhiYTk=
2025-11-01 20:02:18,678 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cfc1be79-ed1c-4ff3-bbe4-d3c7cf5c22b9, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:18,684 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDZiYjk5MGUtZTM2M2YzYTItNTRlMTY0MzYtN2U2NDhiYTk=
2025-11-01 20:02:18,710 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVjNDBkY2QtYzU0MWU3ZDYtY2E2YzI5MTMtZmYzY2JjYzM=
2025-11-01 20:02:18,718 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 23c38c70-2890-4d8e-9400-a62c88e56930, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:18,824 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVjNDBkY2QtYzU0MWU3ZDYtY2E2YzI5MTMtZmYzY2JjYzM=
2025-11-01 20:02:18,826 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0c4d0283-b87c-4812-b0b5-0611f8219f11, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:18,825 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 23c38c70-2890-4d8e-9400-a62c88e56930, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=NDZiYjk5MGUtZTM2M2YzYTItNTRlMTY0MzYtN2U2NDhiYTk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` WHERE (timestamp >= CurrentUtcTimestamp() - DateTime::IntervalFromHours(11)) AND (timestamp <= CurrentUtcTimestamp() - DateTime::IntervalFromHours(10))" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:18,828 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0c4d0283-b87c-4812-b0b5-0611f8219f11, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=NzVjNDBkY2QtYzU0MWU3ZDYtY2E2YzI5MTMtZmYzY2JjYzM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(5)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:18,830 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZjA5Mjc3MzctYzE1MTA4ZDEtMjdiMGM5MzktMjAzYmY2YTY=
2025-11-01 20:02:18,843 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=M2FmMTljM2QtYjM5ZDY2MjUtMmVmMmE3ZjgtZjliN2EzZTc=
2025-11-01 20:02:18,870 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 23c38c70-2890-4d8e-9400-a62c88e56930, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:18,916 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0c4d0283-b87c-4812-b0b5-0611f8219f11, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:18,927 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZjA5Mjc3MzctYzE1MTA4ZDEtMjdiMGM5MzktMjAzYmY2YTY=
2025-11-01 20:02:19,024 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, dc6fef9a-0d7b-460c-93a4-4364a6c9439e, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:19,050 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, dc6fef9a-0d7b-460c-93a4-4364a6c9439e, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=ZjA5Mjc3MzctYzE1MTA4ZDEtMjdiMGM5MzktMjAzYmY2YTY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` WHERE (timestamp >= CurrentUtcTimestamp() - DateTime::IntervalFromHours(9)) AND (timestamp <= CurrentUtcTimestamp() - DateTime::IntervalFromHours(8))" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:19,039 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYwODM1YWItOWE5Y2RhYjYtNzZlN2IyNTQtOTQzNjhiNWY=
2025-11-01 20:02:19,024 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2FmMTljM2QtYjM5ZDY2MjUtMmVmMmE3ZjgtZjliN2EzZTc=
2025-11-01 20:02:19,052 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZGEwOGY3ZWEtNWZmOGRlM2EtY2U3N2E5ZjQtZDFlZjQwMA==
2025-11-01 20:02:19,105 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, dc6fef9a-0d7b-460c-93a4-4364a6c9439e, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:19,218 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0b0c5b0e-3604-446a-b1fd-57f9bc864b2c, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:19,232 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYwODM1YWItOWE5Y2RhYjYtNzZlN2IyNTQtOTQzNjhiNWY=
2025-11-01 20:02:19,348 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0b0c5b0e-3604-446a-b1fd-57f9bc864b2c, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=M2FmMTljM2QtYjM5ZDY2MjUtMmVmMmE3ZjgtZjliN2EzZTc=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(6)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:19,350 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0d77c3fc-41f7-445f-8b22-65fe06b864bf, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:19,352 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0d77c3fc-41f7-445f-8b22-65fe06b864bf, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=ZWYwODM1YWItOWE5Y2RhYjYtNzZlN2IyNTQtOTQzNjhiNWY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(4)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:19,351 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZGEwOGY3ZWEtNWZmOGRlM2EtY2U3N2E5ZjQtZDFlZjQwMA==
2025-11-01 20:02:19,370 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0b0c5b0e-3604-446a-b1fd-57f9bc864b2c, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:19,438 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 143c1996-de12-4739-89d9-cec022bfcd01, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:19,420 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MmFiZjcxYWQtNzI0ZmMzZmMtZDEzZDhmMTEtOTU4ODg4NmQ=
2025-11-01 20:02:19,428 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MTNjM2M0NDktYWE3NGRmMzMtM2QwZWUtYTg4ZWFiN2E=
2025-11-01 20:02:19,441 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 143c1996-de12-4739-89d9-cec022bfcd01, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=ZGEwOGY3ZWEtNWZmOGRlM2EtY2U3N2E5ZjQtZDFlZjQwMA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(4)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:19,384 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0d77c3fc-41f7-445f-8b22-65fe06b864bf, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:19,547 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmFiZjcxYWQtNzI0ZmMzZmMtZDEzZDhmMTEtOTU4ODg4NmQ=
2025-11-01 20:02:19,712 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 143c1996-de12-4739-89d9-cec022bfcd01, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:19,713 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6cb94fcf-890c-4036-9859-039239462a81, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:19,714 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6cb94fcf-890c-4036-9859-039239462a81, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=MmFiZjcxYWQtNzI0ZmMzZmMtZDEzZDhmMTEtOTU4ODg4NmQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(9)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:19,713 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTNjM2M0NDktYWE3NGRmMzMtM2QwZWUtYTg4ZWFiN2E=
2025-11-01 20:02:19,738 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6cb94fcf-890c-4036-9859-039239462a81, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:19,762 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d91e0c3a-be05-45dc-b54b-8bb29795583b, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:19,800 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d91e0c3a-be05-45dc-b54b-8bb29795583b, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=MTNjM2M0NDktYWE3NGRmMzMtM2QwZWUtYTg4ZWFiN2E=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(2)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:19,802 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d91e0c3a-be05-45dc-b54b-8bb29795583b, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:21,382 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZjA5Mjc3MzctYzE1MTA4ZDEtMjdiMGM5MzktMjAzYmY2YTY=
2025-11-01 20:02:21,383 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZjA5Mjc3MzctYzE1MTA4ZDEtMjdiMGM5MzktMjAzYmY2YTY=
2025-11-01 20:02:21,392 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c7cbcebf-cdb0-4550-a68f-305585f7f301, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:21,392 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c7cbcebf-cdb0-4550-a68f-305585f7f301, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=ZjA5Mjc3MzctYzE1MTA4ZDEtMjdiMGM5MzktMjAzYmY2YTY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:21,422 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c7cbcebf-cdb0-4550-a68f-305585f7f301, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:22,485 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDZiYjk5MGUtZTM2M2YzYTItNTRlMTY0MzYtN2U2NDhiYTk=
2025-11-01 20:02:22,486 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDZiYjk5MGUtZTM2M2YzYTItNTRlMTY0MzYtN2U2NDhiYTk=
2025-11-01 20:02:22,486 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 42e0a1bb-0709-4772-ab45-1e1d7fad497f, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:22,487 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 42e0a1bb-0709-4772-ab45-1e1d7fad497f, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=NDZiYjk5MGUtZTM2M2YzYTItNTRlMTY0MzYtN2U2NDhiYTk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:22,488 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 42e0a1bb-0709-4772-ab45-1e1d7fad497f, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:22,624 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2VhZTVhMmYtYjcxMjM0NWEtYWNlNDAzMWQtNWI3ODEzODQ=
2025-11-01 20:02:22,630 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2VhZTVhMmYtYjcxMjM0NWEtYWNlNDAzMWQtNWI3ODEzODQ=
2025-11-01 20:02:22,640 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8c4e8291-dd29-4388-a1fd-e491c5d28ad8, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:22,644 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8c4e8291-dd29-4388-a1fd-e491c5d28ad8, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=N2VhZTVhMmYtYjcxMjM0NWEtYWNlNDAzMWQtNWI3ODEzODQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` WHERE (timestamp >= CurrentUtcTimestamp() - DateTime::IntervalFromHours(10)) AND (timestamp <= CurrentUtcTimestamp() - DateTime::IntervalFromHours(9))" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:22,645 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8c4e8291-dd29-4388-a1fd-e491c5d28ad8, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:22,744 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NTRhNWE5MjAtYjNkNGIwZjItMzZiOGY5NjctOTlkYWQ2NGQ=
2025-11-01 20:02:22,760 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NTRhNWE5MjAtYjNkNGIwZjItMzZiOGY5NjctOTlkYWQ2NGQ=
2025-11-01 20:02:22,803 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0ee596db-2b5b-4b2a-8811-af7c89d6719f, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:22,804 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0ee596db-2b5b-4b2a-8811-af7c89d6719f, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=NTRhNWE5MjAtYjNkNGIwZjItMzZiOGY5NjctOTlkYWQ2NGQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` WHERE (timestamp >= CurrentUtcTimestamp() - DateTime::IntervalFromHours(3)) AND (timestamp <= CurrentUtcTimestamp() - DateTime::IntervalFromHours(2))" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:22,805 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0ee596db-2b5b-4b2a-8811-af7c89d6719f, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:23,057 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZGEwOGY3ZWEtNWZmOGRlM2EtY2U3N2E5ZjQtZDFlZjQwMA==
2025-11-01 20:02:23,058 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZGEwOGY3ZWEtNWZmOGRlM2EtY2U3N2E5ZjQtZDFlZjQwMA==
2025-11-01 20:02:23,077 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 31a7f51e-d2c5-49fd-b152-0f8643c91641, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:23,075 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MTNjM2M0NDktYWE3NGRmMzMtM2QwZWUtYTg4ZWFiN2E=
2025-11-01 20:02:23,058 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=M2FmMTljM2QtYjM5ZDY2MjUtMmVmMmE3ZjgtZjliN2EzZTc=
2025-11-01 20:02:23,078 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 31a7f51e-d2c5-49fd-b152-0f8643c91641, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=ZGEwOGY3ZWEtNWZmOGRlM2EtY2U3N2E5ZjQtZDFlZjQwMA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` WHERE (timestamp >= CurrentUtcTimestamp() - DateTime::IntervalFromHours(5)) AND (timestamp <= CurrentUtcTimestamp() - DateTime::IntervalFromHours(4))" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:23,079 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2FmMTljM2QtYjM5ZDY2MjUtMmVmMmE3ZjgtZjliN2EzZTc=
2025-11-01 20:02:23,095 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 31a7f51e-d2c5-49fd-b152-0f8643c91641, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:23,097 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f364613b-a83e-4623-897d-7699d7d7af0c, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:23,099 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f364613b-a83e-4623-897d-7699d7d7af0c, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=M2FmMTljM2QtYjM5ZDY2MjUtMmVmMmE3ZjgtZjliN2EzZTc=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` WHERE (timestamp >= CurrentUtcTimestamp() - DateTime::IntervalFromHours(3)) AND (timestamp <= CurrentUtcTimestamp() - DateTime::IntervalFromHours(2))" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:23,097 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTNjM2M0NDktYWE3NGRmMzMtM2QwZWUtYTg4ZWFiN2E=
2025-11-01 20:02:23,116 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8e82d0f5-d17e-4129-8dcb-66505beb6709, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:23,116 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8e82d0f5-d17e-4129-8dcb-66505beb6709, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=MTNjM2M0NDktYWE3NGRmMzMtM2QwZWUtYTg4ZWFiN2E=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` WHERE (timestamp >= CurrentUtcTimestamp() - DateTime::IntervalFromHours(7)) AND (timestamp <= CurrentUtcTimestamp() - DateTime::IntervalFromHours(6))" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:23,117 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8e82d0f5-d17e-4129-8dcb-66505beb6709, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:23,101 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f364613b-a83e-4623-897d-7699d7d7af0c, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:23,372 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MmFiZjcxYWQtNzI0ZmMzZmMtZDEzZDhmMTEtOTU4ODg4NmQ=
2025-11-01 20:02:23,384 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmFiZjcxYWQtNzI0ZmMzZmMtZDEzZDhmMTEtOTU4ODg4NmQ=
2025-11-01 20:02:23,385 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 24812703-0723-4894-9126-e7b881b1c54d, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:23,404 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 24812703-0723-4894-9126-e7b881b1c54d, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=MmFiZjcxYWQtNzI0ZmMzZmMtZDEzZDhmMTEtOTU4ODg4NmQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` WHERE (timestamp >= CurrentUtcTimestamp() - DateTime::IntervalFromHours(10)) AND (timestamp <= CurrentUtcTimestamp() - DateTime::IntervalFromHours(9))" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:23,417 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 24812703-0723-4894-9126-e7b881b1c54d, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:23,649 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYwODM1YWItOWE5Y2RhYjYtNzZlN2IyNTQtOTQzNjhiNWY=
2025-11-01 20:02:23,650 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYwODM1YWItOWE5Y2RhYjYtNzZlN2IyNTQtOTQzNjhiNWY=
2025-11-01 20:02:23,650 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 418957a2-545f-48c3-91fd-a41c77b2b57c, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:23,651 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 418957a2-545f-48c3-91fd-a41c77b2b57c, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=ZWYwODM1YWItOWE5Y2RhYjYtNzZlN2IyNTQtOTQzNjhiNWY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` WHERE (timestamp >= CurrentUtcTimestamp() - DateTime::IntervalFromHours(5)) AND (timestamp <= CurrentUtcTimestamp() - DateTime::IntervalFromHours(4))" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:23,653 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 418957a2-545f-48c3-91fd-a41c77b2b57c, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:24,744 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVjNDBkY2QtYzU0MWU3ZDYtY2E2YzI5MTMtZmYzY2JjYzM=
2025-11-01 20:02:24,745 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVjNDBkY2QtYzU0MWU3ZDYtY2E2YzI5MTMtZmYzY2JjYzM=
2025-11-01 20:02:24,745 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ef2b9994-6a5e-4706-9d46-4317db06aadf, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:24,747 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ef2b9994-6a5e-4706-9d46-4317db06aadf, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=NzVjNDBkY2QtYzU0MWU3ZDYtY2E2YzI5MTMtZmYzY2JjYzM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` WHERE (timestamp >= CurrentUtcTimestamp() - DateTime::IntervalFromHours(6)) AND (timestamp <= CurrentUtcTimestamp() - DateTime::IntervalFromHours(5))" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:24,752 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ef2b9994-6a5e-4706-9d46-4317db06aadf, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:24,890 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2VhZTVhMmYtYjcxMjM0NWEtYWNlNDAzMWQtNWI3ODEzODQ=
2025-11-01 20:02:24,892 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2VhZTVhMmYtYjcxMjM0NWEtYWNlNDAzMWQtNWI3ODEzODQ=
2025-11-01 20:02:24,892 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c62152d5-03b4-4d7f-80c8-13aff5cf04c1, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:24,893 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c62152d5-03b4-4d7f-80c8-13aff5cf04c1, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=N2VhZTVhMmYtYjcxMjM0NWEtYWNlNDAzMWQtNWI3ODEzODQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:24,940 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZGEwOGY3ZWEtNWZmOGRlM2EtY2U3N2E5ZjQtZDFlZjQwMA==
2025-11-01 20:02:24,941 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=M2FmMTljM2QtYjM5ZDY2MjUtMmVmMmE3ZjgtZjliN2EzZTc=
2025-11-01 20:02:24,942 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MmFiZjcxYWQtNzI0ZmMzZmMtZDEzZDhmMTEtOTU4ODg4NmQ=
2025-11-01 20:02:24,942 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYwODM1YWItOWE5Y2RhYjYtNzZlN2IyNTQtOTQzNjhiNWY=
2025-11-01 20:02:24,943 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NTRhNWE5MjAtYjNkNGIwZjItMzZiOGY5NjctOTlkYWQ2NGQ=
2025-11-01 20:02:24,946 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c62152d5-03b4-4d7f-80c8-13aff5cf04c1, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:24,946 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZGEwOGY3ZWEtNWZmOGRlM2EtY2U3N2E5ZjQtZDFlZjQwMA==
2025-11-01 20:02:24,949 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MTNjM2M0NDktYWE3NGRmMzMtM2QwZWUtYTg4ZWFiN2E=
2025-11-01 20:02:25,022 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 03a29077-0b70-4331-9bf1-071a7bdd006b, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:25,025 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2FmMTljM2QtYjM5ZDY2MjUtMmVmMmE3ZjgtZjliN2EzZTc=
2025-11-01 20:02:25,036 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 03a29077-0b70-4331-9bf1-071a7bdd006b, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=ZGEwOGY3ZWEtNWZmOGRlM2EtY2U3N2E5ZjQtZDFlZjQwMA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:25,044 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ad03a0be-6d8d-4018-b4d2-4ff42d07aa9f, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:25,044 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYwODM1YWItOWE5Y2RhYjYtNzZlN2IyNTQtOTQzNjhiNWY=
2025-11-01 20:02:25,064 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 09685720-f5a0-43ef-9563-15727f31adc7, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:25,052 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ad03a0be-6d8d-4018-b4d2-4ff42d07aa9f, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=M2FmMTljM2QtYjM5ZDY2MjUtMmVmMmE3ZjgtZjliN2EzZTc=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:25,083 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ad03a0be-6d8d-4018-b4d2-4ff42d07aa9f, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:25,048 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 03a29077-0b70-4331-9bf1-071a7bdd006b, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:25,066 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 09685720-f5a0-43ef-9563-15727f31adc7, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=ZWYwODM1YWItOWE5Y2RhYjYtNzZlN2IyNTQtOTQzNjhiNWY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:25,065 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmFiZjcxYWQtNzI0ZmMzZmMtZDEzZDhmMTEtOTU4ODg4NmQ=
2025-11-01 20:02:25,116 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f53e0ef6-c129-4dc2-a920-44421cae8465, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:25,117 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f53e0ef6-c129-4dc2-a920-44421cae8465, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=MmFiZjcxYWQtNzI0ZmMzZmMtZDEzZDhmMTEtOTU4ODg4NmQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:25,117 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f53e0ef6-c129-4dc2-a920-44421cae8465, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:25,118 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NTRhNWE5MjAtYjNkNGIwZjItMzZiOGY5NjctOTlkYWQ2NGQ=
2025-11-01 20:02:25,090 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 09685720-f5a0-43ef-9563-15727f31adc7, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:25,119 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 05f1d493-d5ed-4496-a68e-6f8ba9b6c4fc, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:25,119 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTNjM2M0NDktYWE3NGRmMzMtM2QwZWUtYTg4ZWFiN2E=
2025-11-01 20:02:25,141 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 05f1d493-d5ed-4496-a68e-6f8ba9b6c4fc, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=NTRhNWE5MjAtYjNkNGIwZjItMzZiOGY5NjctOTlkYWQ2NGQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:25,157 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 05f1d493-d5ed-4496-a68e-6f8ba9b6c4fc, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:25,142 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 43038da3-890f-4dbc-89ab-0cad10355f3b, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:25,158 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 43038da3-890f-4dbc-89ab-0cad10355f3b, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=MTNjM2M0NDktYWE3NGRmMzMtM2QwZWUtYTg4ZWFiN2E=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:25,159 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 43038da3-890f-4dbc-89ab-0cad10355f3b, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:25,291 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZjA5Mjc3MzctYzE1MTA4ZDEtMjdiMGM5MzktMjAzYmY2YTY=
2025-11-01 20:02:25,304 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZjA5Mjc3MzctYzE1MTA4ZDEtMjdiMGM5MzktMjAzYmY2YTY=
2025-11-01 20:02:25,305 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 78cc1d59-cd27-4e35-918d-87c7798027db, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:25,305 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 78cc1d59-cd27-4e35-918d-87c7798027db, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=ZjA5Mjc3MzctYzE1MTA4ZDEtMjdiMGM5MzktMjAzYmY2YTY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(2)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:25,306 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 78cc1d59-cd27-4e35-918d-87c7798027db, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:26,980 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVjNDBkY2QtYzU0MWU3ZDYtY2E2YzI5MTMtZmYzY2JjYzM=
2025-11-01 20:02:26,980 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVjNDBkY2QtYzU0MWU3ZDYtY2E2YzI5MTMtZmYzY2JjYzM=
2025-11-01 20:02:26,981 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 19ac87c3-9897-4b5d-b014-acff07847688, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:26,982 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 19ac87c3-9897-4b5d-b014-acff07847688, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=NzVjNDBkY2QtYzU0MWU3ZDYtY2E2YzI5MTMtZmYzY2JjYzM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` " } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:27,010 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 19ac87c3-9897-4b5d-b014-acff07847688, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:27,287 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDZiYjk5MGUtZTM2M2YzYTItNTRlMTY0MzYtN2U2NDhiYTk=
2025-11-01 20:02:27,287 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDZiYjk5MGUtZTM2M2YzYTItNTRlMTY0MzYtN2U2NDhiYTk=
2025-11-01 20:02:27,288 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e52468df-8bcc-49c4-9da5-3204b9be7c04, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:27,297 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e52468df-8bcc-49c4-9da5-3204b9be7c04, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=NDZiYjk5MGUtZTM2M2YzYTItNTRlMTY0MzYtN2U2NDhiYTk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(6)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:27,298 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e52468df-8bcc-49c4-9da5-3204b9be7c04, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:30,583 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=N2VhZTVhMmYtYjcxMjM0NWEtYWNlNDAzMWQtNWI3ODEzODQ=
2025-11-01 20:02:30,592 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MTNjM2M0NDktYWE3NGRmMzMtM2QwZWUtYTg4ZWFiN2E=
2025-11-01 20:02:30,606 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2VhZTVhMmYtYjcxMjM0NWEtYWNlNDAzMWQtNWI3ODEzODQ=
2025-11-01 20:02:30,631 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2a7eee7c-51c8-4f42-8aae-313e8f7bd800, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:30,631 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2a7eee7c-51c8-4f42-8aae-313e8f7bd800, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=N2VhZTVhMmYtYjcxMjM0NWEtYWNlNDAzMWQtNWI3ODEzODQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(3)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:30,633 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2a7eee7c-51c8-4f42-8aae-313e8f7bd800, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:30,630 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYwODM1YWItOWE5Y2RhYjYtNzZlN2IyNTQtOTQzNjhiNWY=
2025-11-01 20:02:30,636 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTNjM2M0NDktYWE3NGRmMzMtM2QwZWUtYTg4ZWFiN2E=
2025-11-01 20:02:30,648 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZGEwOGY3ZWEtNWZmOGRlM2EtY2U3N2E5ZjQtZDFlZjQwMA==
2025-11-01 20:02:30,648 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MmFiZjcxYWQtNzI0ZmMzZmMtZDEzZDhmMTEtOTU4ODg4NmQ=
2025-11-01 20:02:30,668 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ea58b560-83a1-493d-831b-9c650cfcf678, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:30,668 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYwODM1YWItOWE5Y2RhYjYtNzZlN2IyNTQtOTQzNjhiNWY=
2025-11-01 20:02:30,685 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NTRhNWE5MjAtYjNkNGIwZjItMzZiOGY5NjctOTlkYWQ2NGQ=
2025-11-01 20:02:30,725 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ea58b560-83a1-493d-831b-9c650cfcf678, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=MTNjM2M0NDktYWE3NGRmMzMtM2QwZWUtYTg4ZWFiN2E=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(8)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:30,725 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=M2FmMTljM2QtYjM5ZDY2MjUtMmVmMmE3ZjgtZjliN2EzZTc=
2025-11-01 20:02:30,741 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7c6f7916-b4f8-45a7-a05d-cf0a6ec6963a, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:30,817 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7c6f7916-b4f8-45a7-a05d-cf0a6ec6963a, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=ZWYwODM1YWItOWE5Y2RhYjYtNzZlN2IyNTQtOTQzNjhiNWY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(7)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:30,792 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ea58b560-83a1-493d-831b-9c650cfcf678, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:30,742 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZGEwOGY3ZWEtNWZmOGRlM2EtY2U3N2E5ZjQtZDFlZjQwMA==
2025-11-01 20:02:30,818 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8e519030-88d9-4b57-9973-8bc8d2adabea, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:30,822 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8e519030-88d9-4b57-9973-8bc8d2adabea, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=ZGEwOGY3ZWEtNWZmOGRlM2EtY2U3N2E5ZjQtZDFlZjQwMA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(6)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:30,820 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7c6f7916-b4f8-45a7-a05d-cf0a6ec6963a, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:30,818 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmFiZjcxYWQtNzI0ZmMzZmMtZDEzZDhmMTEtOTU4ODg4NmQ=
2025-11-01 20:02:30,828 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8e519030-88d9-4b57-9973-8bc8d2adabea, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:30,987 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 05fbb09d-6e93-4cec-a347-aa2e65cb50f4, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:30,987 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NTRhNWE5MjAtYjNkNGIwZjItMzZiOGY5NjctOTlkYWQ2NGQ=
2025-11-01 20:02:31,018 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 05fbb09d-6e93-4cec-a347-aa2e65cb50f4, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=MmFiZjcxYWQtNzI0ZmMzZmMtZDEzZDhmMTEtOTU4ODg4NmQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(5)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:31,019 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7f870545-9d03-47cd-866a-b8e1f00c4ea5, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:31,020 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=M2FmMTljM2QtYjM5ZDY2MjUtMmVmMmE3ZjgtZjliN2EzZTc=
2025-11-01 20:02:31,023 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 05fbb09d-6e93-4cec-a347-aa2e65cb50f4, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:31,043 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZjA5Mjc3MzctYzE1MTA4ZDEtMjdiMGM5MzktMjAzYmY2YTY=
2025-11-01 20:02:31,043 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7f870545-9d03-47cd-866a-b8e1f00c4ea5, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=NTRhNWE5MjAtYjNkNGIwZjItMzZiOGY5NjctOTlkYWQ2NGQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(7)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:31,058 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1fc86eda-9de1-4db3-a8ef-83c2499bf0dc, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:31,216 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZjA5Mjc3MzctYzE1MTA4ZDEtMjdiMGM5MzktMjAzYmY2YTY=
2025-11-01 20:02:31,226 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f0c32894-7df4-45ea-b53f-1354dac59d1c, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:31,226 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f0c32894-7df4-45ea-b53f-1354dac59d1c, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=ZjA5Mjc3MzctYzE1MTA4ZDEtMjdiMGM5MzktMjAzYmY2YTY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(2)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:31,225 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1fc86eda-9de1-4db3-a8ef-83c2499bf0dc, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=M2FmMTljM2QtYjM5ZDY2MjUtMmVmMmE3ZjgtZjliN2EzZTc=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(10)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:31,224 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7f870545-9d03-47cd-866a-b8e1f00c4ea5, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:31,236 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f0c32894-7df4-45ea-b53f-1354dac59d1c, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:31,237 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1fc86eda-9de1-4db3-a8ef-83c2499bf0dc, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:31,432 - DEBUG - ya.test - _wait: Process resource usage is not available as process finished before wait4 was called
2025-11-01 20:02:31,436 - DEBUG - ya.test - _save_outputs: Command (pid 3372635) rc: 0
2025-11-01 20:02:31,436 - DEBUG - ya.test - _save_outputs: Command (pid 3372635) elapsed time (sec): 31.096132278442383
2025-11-01 20:02:31,437 - DEBUG - ya.test - _save_outputs: Command (pid 3372635) wtime: 31.11
2025-11-01 20:02:31,437 - DEBUG - ya.test - _save_outputs: Command (pid 3372635) output:
Window	    Txs	Txs/Sec	Retries	Errors	p50(ms)	p95(ms)	p99(ms)	pMax(ms)
1	     18	18	0	0	489	623	623	623
2	     13	13	0	0	671	783	823	823
3	     27	27	0	0	487	571	607	607
4	     13	13	0	0	747	839	851	851
5	     19	19	0	0	459	523	615	615
6	      4	4	0	8	659	943	943	943
7	     14	14	0	0	703	831	851	851
8	     16	16	0	0	651	827	903	903
9	     13	13	0	0	631	763	887	887
10	      9	9	0	1	879	983	983	983
11	     56	56	0	3	126	827	959	987
12	     72	72	0	0	145	187	189	198
13	     91	91	0	0	107	143	149	151
14	     80	80	0	0	132	161	166	175
15	     90	90	0	0	111	155	156	161
16	     97	97	0	0	98	150	166	167
17	     86	86	0	0	111	175	190	194
18	     49	49	0	0	127	377	393	393
19	     16	16	0	0	327	671	695	695
20	     23	23	0	0	515	847	847	847
21	     20	20	0	0	477	575	583	583
22	     22	22	0	0	479	535	539	539
23	     11	11	0	0	539	803	839	839
24	     27	27	0	0	331	923	935	935
25	     16	16	0	0	543	767	771	771
26	     23	23	0	0	429	899	943	943
27	     15	15	0	0	489	819	835	835
28	     16	16	0	0	615	823	827	827
29	     14	14	0	0	675	731	779	779
30	     18	18	0	6	695	827	875	875

Total	    Txs	Txs/Sec	Retries	Errors	p50(ms)	p95(ms)	p99(ms)	pMax(ms)
30	    988	32.9333	0	18	147	807	923	987

2025-11-01 20:02:31,437 - DEBUG - ya.test - _save_outputs: Command (pid 3372635) errors:

2025-11-01 20:02:31,446 - DEBUG - ya.test - _wait: Process resource usage is not available as process finished before wait4 was called
2025-11-01 20:02:31,453 - DEBUG - ya.test - _save_outputs: Command (pid 3372513) rc: 0
2025-11-01 20:02:31,454 - DEBUG - ya.test - _save_outputs: Command (pid 3372513) elapsed time (sec): 31.12191677093506
2025-11-01 20:02:31,454 - DEBUG - ya.test - _save_outputs: Command (pid 3372513) wtime: 31.156
2025-11-01 20:02:31,454 - DEBUG - ya.test - _save_outputs: Command (pid 3372513) output:
Window	    Txs	Txs/Sec	Retries	Errors	p50(ms)	p95(ms)	p99(ms)	pMax(ms)
1	     30	30	0	0	249	441	445	445
2	     20	20	0	0	477	659	675	675
3	     29	29	0	0	391	435	459	459
4	     20	20	0	0	495	691	767	767
5	     22	22	0	0	291	493	511	511
6	     12	12	0	0	1023	1223	1231	1231
7	     18	18	0	0	603	675	691	691
8	     20	20	0	0	431	711	739	739
9	     14	14	0	0	497	707	723	723
10	     11	11	0	0	759	823	871	871
11	     83	83	0	0	95	1023	1103	1103
12	     89	89	0	0	115	170	175	182
13	    125	125	0	0	79	112	119	121
14	    113	113	0	0	93	122	133	134
15	    120	120	0	0	81	127	146	146
16	    144	144	0	0	62	117	132	133
17	    116	116	0	0	84	138	150	152
18	     63	63	0	0	99	331	335	339
19	     21	21	0	0	307	489	675	675
20	     30	30	0	0	331	691	751	751
21	     25	25	0	0	395	467	481	481
22	     28	28	0	0	371	439	443	443
23	     14	14	0	0	477	723	739	739
24	     36	36	0	0	227	743	787	787
25	     14	14	0	0	415	439	441	441
26	     32	32	0	0	363	795	811	811
27	     19	19	0	0	457	711	731	731
28	     20	20	0	0	495	575	583	583
29	     18	18	0	0	539	627	643	643
30	     29	29	0	0	603	967	995	995

Total	    Txs	Txs/Sec	Retries	Errors	p50(ms)	p95(ms)	p99(ms)	pMax(ms)
30	   1335	44.5	0	0	108	679	983	1231

2025-11-01 20:02:31,454 - DEBUG - ya.test - _save_outputs: Command (pid 3372513) errors:

2025-11-01 20:02:31,506 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVjNDBkY2QtYzU0MWU3ZDYtY2E2YzI5MTMtZmYzY2JjYzM=
2025-11-01 20:02:31,549 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVjNDBkY2QtYzU0MWU3ZDYtY2E2YzI5MTMtZmYzY2JjYzM=
2025-11-01 20:02:31,550 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b2a10066-8904-4995-93a7-f770482eff2b, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:31,564 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b2a10066-8904-4995-93a7-f770482eff2b, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=NzVjNDBkY2QtYzU0MWU3ZDYtY2E2YzI5MTMtZmYzY2JjYzM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(4)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:31,566 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b2a10066-8904-4995-93a7-f770482eff2b, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:31,602 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDZiYjk5MGUtZTM2M2YzYTItNTRlMTY0MzYtN2U2NDhiYTk=
2025-11-01 20:02:31,710 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDZiYjk5MGUtZTM2M2YzYTItNTRlMTY0MzYtN2U2NDhiYTk=
2025-11-01 20:02:31,728 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e8e4cca2-6817-413f-9c2c-547d18bd0091, ghrun-mjpjznvske.auto.internal:64916): creating call state
2025-11-01 20:02:31,755 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e8e4cca2-6817-413f-9c2c-547d18bd0091, ghrun-mjpjznvske.auto.internal:64916): request = { session_id: "ydb://session/3?node_id=1&id=NDZiYjk5MGUtZTM2M2YzYTItNTRlMTY0MzYtN2U2NDhiYTk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) FROM `log` WHERE timestamp < CurrentUtcTimestamp() - DateTime::IntervalFromHours(6)" } stats_mode: STATS_MODE_NONE }
2025-11-01 20:02:31,756 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e8e4cca2-6817-413f-9c2c-547d18bd0091, ghrun-mjpjznvske.auto.internal:64916): response = { <_MultiThreadedRendezvous object> }
2025-11-01 20:02:31,714 - DEBUG - ya.test - _wait: Process resource usage is not available as process finished before wait4 was called
2025-11-01 20:02:31,763 - DEBUG - ya.test - _save_outputs: Command (pid 3372516) rc: 0
2025-11-01 20:02:31,764 - DEBUG - ya.test - _save_outputs: Command (pid 3372516) elapsed time (sec): 31.437647819519043
2025-11-01 20:02:31,765 - DEBUG - ya.test - _save_outputs: Command (pid 3372516) wtime: 31.467
2025-11-01 20:02:31,766 - DEBUG - ya.test - _save_outputs: Command (pid 3372516) output:
Window	    Txs	Txs/Sec	Retries	Errors	p50(ms)	p95(ms)	p99(ms)	pMax(ms)
1	      4	4	0	0	755	999	999	999
2	      2	2	0	8	891	935	935	935
3	     10	10	0	7	795	967	967	967
4	      9	9	0	1	403	895	895	895
5	      7	7	0	4	823	971	971	971
6	      1	1	0	9	1015	1015	1015	1015
7	      4	4	0	5	1039	1079	1079	1079
8	      0	0	0	10	0	0	0	0
9	      2	2	0	8	831	911	911	911
10	      0	0	0	10	0	0	0	0
11	     43	43	0	3	145	967	1031	1031
12	     62	62	0	0	183	235	239	244
13	     78	78	0	0	130	161	164	170
14	     70	70	0	0	146	174	179	180
15	     78	78	0	0	129	194	198	208
16	     81	81	0	0	119	169	176	189
17	     73	73	0	0	135	198	206	207
18	     38	38	0	0	133	463	475	475
19	     15	15	0	0	379	739	899	899
20	      4	4	0	6	927	947	947	947
21	      2	2	0	9	855	875	875	875
22	      4	4	0	6	883	1015	1015	1015
23	      6	6	0	4	831	999	999	999
24	      3	3	0	8	839	883	883	883
25	      5	5	0	5	887	1019	1019	1019
26	     11	11	0	5	743	1047	1055	1055
27	      6	6	0	5	851	1007	1007	1007
28	      4	4	0	6	895	999	999	999
29	      1	1	0	5	927	927	927	927
30	      2	2	0	18	971	979	979	979

Total	    Txs	Txs/Sec	Retries	Errors	p50(ms)	p95(ms)	p99(ms)	pMax(ms)
30	    625	20.8333	0	142	144	935	1031	1079

2025-11-01 20:02:31,766 - DEBUG - ya.test - _save_outputs: Command (pid 3372516) errors:

2025-11-01 20:02:37,788 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(AttachSession, 285462d1-a2ab-4601-a39e-91a787c983ff, ghrun-mjpjznvske.auto.internal:64916): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer ipv4:127.0.1.1:64916 {file:"/home/runner/actions_runner/_work/ydb/ydb/contrib/libs/grpc/src/core/lib/surface/call.cc", file_line:1211, created_time:"2025-11-01T20:02:37.784883045+00:00", grpc_status:14, grpc_message:"recvmsg:Connection reset by peer"}"
>
2025-11-01 20:02:37,789 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(AttachSession, 2399150a-29a4-4cbb-8b8c-81509c43bf74, ghrun-mjpjznvske.auto.internal:64916): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer ipv4:127.0.1.1:64916 {file:"/home/runner/actions_runner/_work/ydb/ydb/contrib/libs/grpc/src/core/lib/surface/call.cc", file_line:1211, created_time:"2025-11-01T20:02:37.784899345+00:00", grpc_status:14, grpc_message:"recvmsg:Connection reset by peer"}"
>
2025-11-01 20:02:37,791 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(AttachSession, cfd8aa4c-aabf-42de-ac63-d39447c8c337, ghrun-mjpjznvske.auto.internal:64916): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer ipv4:127.0.1.1:64916 {file:"/home/runner/actions_runner/_work/ydb/ydb/contrib/libs/grpc/src/core/lib/surface/call.cc", file_line:1211, created_time:"2025-11-01T20:02:37.784952274+00:00", grpc_status:14, grpc_message:"recvmsg:Connection reset by peer"}"
>
2025-11-01 20:02:37,796 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(AttachSession, af1d29be-e4b3-44df-ad1b-a259ce9c5270, ghrun-mjpjznvske.auto.internal:64916): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer ipv4:127.0.1.1:64916 {file:"/home/runner/actions_runner/_work/ydb/ydb/contrib/libs/grpc/src/core/lib/surface/call.cc", file_line:1211, created_time:"2025-11-01T20:02:37.784970556+00:00", grpc_status:14, grpc_message:"recvmsg:Connection reset by peer"}"
>
2025-11-01 20:02:37,797 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(AttachSession, 4bb9393d-c3ea-497d-84a2-8a646916f99c, ghrun-mjpjznvske.auto.internal:64916): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer ipv4:127.0.1.1:64916 {file:"/home/runner/actions_runner/_work/ydb/ydb/contrib/libs/grpc/src/core/lib/surface/call.cc", file_line:1211, created_time:"2025-11-01T20:02:37.784927355+00:00", grpc_status:14, grpc_message:"recvmsg:Connection reset by peer"}"
>
2025-11-01 20:02:37,798 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(AttachSession, 07abae14-f866-499e-a4ec-665dca604595, ghrun-mjpjznvske.auto.internal:64916): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer ipv4:127.0.1.1:64916 {grpc_message:"recvmsg:Connection reset by peer", grpc_status:14, created_time:"2025-11-01T20:02:37.784986774+00:00", file_line:1211, file:"/home/runner/actions_runner/_work/ydb/ydb/contrib/libs/grpc/src/core/lib/surface/call.cc"}"
>
2025-11-01 20:02:37,836 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-mjpjznvske.auto.internal:64916
2025-11-01 20:02:37,801 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(AttachSession, cf9b5e0b-2460-4d21-b7c9-9289835988c3, ghrun-mjpjznvske.auto.internal:64916): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer ipv4:127.0.1.1:64916 {file:"/home/runner/actions_runner/_work/ydb/ydb/contrib/libs/grpc/src/core/lib/surface/call.cc", file_line:1211, created_time:"2025-11-01T20:02:37.785047238+00:00", grpc_status:14, grpc_message:"recvmsg:Connection reset by peer"}"
>
2025-11-01 20:02:37,801 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(AttachSession, f6893243-5afa-43bc-88d9-e4bf3fba753d, ghrun-mjpjznvske.auto.internal:64916): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer ipv4:127.0.1.1:64916 {file:"/home/runner/actions_runner/_work/ydb/ydb/contrib/libs/grpc/src/core/lib/surface/call.cc", file_line:1211, created_time:"2025-11-01T20:02:37.785000401+00:00", grpc_status:14, grpc_message:"recvmsg:Connection reset by peer"}"
>
2025-11-01 20:02:37,801 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(AttachSession, 7d974700-585b-415c-a54f-fd7d590aa521, ghrun-mjpjznvske.auto.internal:64916): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer ipv4:127.0.1.1:64916 {grpc_message:"recvmsg:Connection reset by peer", grpc_status:14, created_time:"2025-11-01T20:02:37.784768018+00:00", file_line:1211, file:"/home/runner/actions_runner/_work/ydb/ydb/contrib/libs/grpc/src/core/lib/surface/call.cc"}"
>
2025-11-01 20:02:37,806 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(ExecuteQuery, 2a7eee7c-51c8-4f42-8aae-313e8f7bd800, ghrun-mjpjznvske.auto.internal:64916): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer ipv4:127.0.1.1:64916 {file:"/home/runner/actions_runner/_work/ydb/ydb/contrib/libs/grpc/src/core/lib/surface/call.cc", file_line:1211, created_time:"2025-11-01T20:02:37.785063782+00:00", grpc_status:14, grpc_message:"recvmsg:Connection reset by peer"}"
>
2025-11-01 20:02:37,802 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-mjpjznvske.auto.internal:64916
2025-11-01 20:02:37,809 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(ExecuteQuery, 7c6f7916-b4f8-45a7-a05d-cf0a6ec6963a, ghrun-mjpjznvske.auto.internal:64916): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer ipv4:127.0.1.1:64916 {file:"/home/runner/actions_runner/_work/ydb/ydb/contrib/libs/grpc/src/core/lib/surface/call.cc", file_line:1211, created_time:"2025-11-01T20:02:37.785103073+00:00", grpc_status:14, grpc_message:"recvmsg:Connection reset by peer"}"
>
2025-11-01 20:02:37,807 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(ExecuteQuery, 05fbb09d-6e93-4cec-a347-aa2e65cb50f4, ghrun-mjpjznvske.auto.internal:64916): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer ipv4:127.0.1.1:64916 {grpc_message:"recvmsg:Connection reset by peer", grpc_status:14, created_time:"2025-11-01T20:02:37.785162611+00:00", file_line:1211, file:"/home/runner/actions_runner/_work/ydb/ydb/contrib/libs/grpc/src/core/lib/surface/call.cc"}"
>
2025-11-01 20:02:37,809 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(ExecuteQuery, 8e519030-88d9-4b57-9973-8bc8d2adabea, ghrun-mjpjznvske.auto.internal:64916): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer ipv4:127.0.1.1:64916 {grpc_message:"recvmsg:Connection reset by peer", grpc_status:14, created_time:"2025-11-01T20:02:37.785125423+00:00", file_line:1211, file:"/home/runner/actions_runner/_work/ydb/ydb/contrib/libs/grpc/src/core/lib/surface/call.cc"}"
>
2025-11-01 20:02:37,806 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(ExecuteQuery, ea58b560-83a1-493d-831b-9c650cfcf678, ghrun-mjpjznvske.auto.internal:64916): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer ipv4:127.0.1.1:64916 {grpc_message:"recvmsg:Connection reset by peer", grpc_status:14, created_time:"2025-11-01T20:02:37.785081372+00:00", file_line:1211, file:"/home/runner/actions_runner/_work/ydb/ydb/contrib/libs/grpc/src/core/lib/surface/call.cc"}"
>
2025-11-01 20:02:37,851 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-mjpjznvske.auto.internal:64916
2025-11-01 20:02:37,809 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(ExecuteQuery, 1fc86eda-9de1-4db3-a8ef-83c2499bf0dc, ghrun-mjpjznvske.auto.internal:64916): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer ipv4:127.0.1.1:64916 {file:"/home/runner/actions_runner/_work/ydb/ydb/contrib/libs/grpc/src/core/lib/surface/call.cc", file_line:1211, created_time:"2025-11-01T20:02:37.78523835+00:00", grpc_status:14, grpc_message:"recvmsg:Connection reset by peer"}"
>
2025-11-01 20:02:37,811 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-mjpjznvske.auto.internal:64916
2025-11-01 20:02:37,811 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-mjpjznvske.auto.internal:64916
2025-11-01 20:02:37,811 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-mjpjznvske.auto.internal:64916
2025-11-01 20:02:37,814 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(ExecuteQuery, b2a10066-8904-4995-93a7-f770482eff2b, ghrun-mjpjznvske.auto.internal:64916): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer ipv4:127.0.1.1:64916 {file:"/home/runner/actions_runner/_work/ydb/ydb/contrib/libs/grpc/src/core/lib/surface/call.cc", file_line:1211, created_time:"2025-11-01T20:02:37.785271908+00:00", grpc_status:14, grpc_message:"recvmsg:Connection reset by peer"}"
>
2025-11-01 20:02:37,887 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-mjpjznvske.auto.internal:64916
2025-11-01 20:02:37,815 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(ExecuteQuery, f0c32894-7df4-45ea-b53f-1354dac59d1c, ghrun-mjpjznvske.auto.internal:64916): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer  {grpc_message:"recvmsg:Connection reset by peer", grpc_status:14, created_time:"2025-11-01T20:02:37.785219066+00:00", file_line:1211, file:"/home/runner/actions_runner/_work/ydb/ydb/contrib/libs/grpc/src/core/lib/surface/call.cc"}"
>
2025-11-01 20:02:37,816 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(ExecuteQuery, e8e4cca2-6817-413f-9c2c-547d18bd0091, ghrun-mjpjznvske.auto.internal:64916): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer  {grpc_message:"recvmsg:Connection reset by peer", grpc_status:14, created_time:"2025-11-01T20:02:37.785283988+00:00", file_line:1211, file:"/home/runner/actions_runner/_work/ydb/ydb/contrib/libs/grpc/src/core/lib/surface/call.cc"}"
>
2025-11-01 20:02:37,799 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(AttachSession, fe0ca978-a77a-469e-a953-5c4a064341cb, ghrun-mjpjznvske.auto.internal:64916): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer ipv4:127.0.1.1:64916 {grpc_message:"recvmsg:Connection reset by peer", grpc_status:14, created_time:"2025-11-01T20:02:37.785032994+00:00", file_line:1211, file:"/home/runner/actions_runner/_work/ydb/ydb/contrib/libs/grpc/src/core/lib/surface/call.cc"}"
>
2025-11-01 20:02:37,845 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-mjpjznvske.auto.internal:64916
2025-11-01 20:02:37,848 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:02:37,929 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:02:37,848 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-mjpjznvske.auto.internal:64916
2025-11-01 20:02:37,849 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-mjpjznvske.auto.internal:64916
2025-11-01 20:02:37,809 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(ExecuteQuery, 7f870545-9d03-47cd-866a-b8e1f00c4ea5, ghrun-mjpjznvske.auto.internal:64916): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.UNAVAILABLE
	details = "recvmsg:Connection reset by peer"
	debug_error_string = "UNKNOWN:Error received from peer ipv4:127.0.1.1:64916 {file:"/home/runner/actions_runner/_work/ydb/ydb/contrib/libs/grpc/src/core/lib/surface/call.cc", file_line:1211, created_time:"2025-11-01T20:02:37.785181326+00:00", grpc_status:14, grpc_message:"recvmsg:Connection reset by peer"}"
>
2025-11-01 20:02:37,851 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-mjpjznvske.auto.internal:64916
2025-11-01 20:02:37,852 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-mjpjznvske.auto.internal:64916
2025-11-01 20:02:37,852 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-mjpjznvske.auto.internal:64916
2025-11-01 20:02:37,880 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYwODM1YWItOWE5Y2RhYjYtNzZlN2IyNTQtOTQzNjhiNWY=
2025-11-01 20:02:37,881 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-mjpjznvske.auto.internal:64916
2025-11-01 20:02:37,836 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-mjpjznvske.auto.internal:64916
2025-11-01 20:02:37,919 - DEBUG - ydb.query.pool - release: Session returned to queue: None
2025-11-01 20:02:37,923 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-mjpjznvske.auto.internal:64916
2025-11-01 20:02:38,172 - DEBUG - ydb.query.pool - release: Session returned to queue: None
2025-11-01 20:02:37,924 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-mjpjznvske.auto.internal:64916
2025-11-01 20:02:38,172 - DEBUG - ydb.query.pool - release: Session returned to queue: None
2025-11-01 20:02:37,925 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-mjpjznvske.auto.internal:64916
2025-11-01 20:02:37,966 - DEBUG - ydb.query.pool - release: Session returned to queue: None
2025-11-01 20:02:37,995 - DEBUG - ydb.query.pool - release: Session returned to queue: None
2025-11-01 20:02:38,045 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZGEwOGY3ZWEtNWZmOGRlM2EtY2U3N2E5ZjQtZDFlZjQwMA==
2025-11-01 20:02:38,098 - DEBUG - ydb.query.pool - release: Session returned to queue: None
2025-11-01 20:02:38,148 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYwODM1YWItOWE5Y2RhYjYtNzZlN2IyNTQtOTQzNjhiNWY=
2025-11-01 20:02:38,175 - DEBUG - ydb.query.pool - release: Session returned to queue: None
2025-11-01 20:02:38,176 - DEBUG - ydb.query.pool - acquire: Acquired dead session from queue: None
2025-11-01 20:02:38,176 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 9 < 100, will create new one.
2025-11-01 20:02:38,151 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=M2FmMTljM2QtYjM5ZDY2MjUtMmVmMmE3ZjgtZjliN2EzZTc=
2025-11-01 20:02:38,178 - DEBUG - ydb.query.pool - acquire: Acquired dead session from queue: None
2025-11-01 20:02:38,179 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 8 < 100, will create new one.
2025-11-01 20:02:37,849 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-mjpjznvske.auto.internal:64916
2025-11-01 20:02:38,180 - DEBUG - ydb.query.pool - acquire: Acquired dead session from queue: None
2025-11-01 20:02:38,181 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 7 < 100, will create new one.
2025-11-01 20:02:38,182 - DEBUG - ydb.query.pool - acquire: Acquired dead session from queue: None
2025-11-01 20:02:38,183 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 6 < 100, will create new one.
2025-11-01 20:02:37,965 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-mjpjznvske.auto.internal:64916
2025-11-01 20:02:38,188 - DEBUG - ydb.query.pool - acquire: Acquired dead session from queue: None
2025-11-01 20:02:38,222 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 5 < 100, will create new one.
2025-11-01 20:02:38,222 - DEBUG - ydb.query.pool - release: Session returned to queue: None
2025-11-01 20:02:38,223 - DEBUG - ydb.query.pool - acquire: Acquired dead session from queue: None
2025-11-01 20:02:38,238 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 4 < 100, will create new one.
2025-11-01 20:02:38,239 - DEBUG - ydb.query.pool - acquire: Acquired dead session from queue: None
2025-11-01 20:02:38,240 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 3 < 100, will create new one.
2025-11-01 20:02:38,240 - DEBUG - ydb.query.pool - acquire: Acquired dead session from queue: None
2025-11-01 20:02:38,248 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 2 < 100, will create new one.
2025-11-01 20:02:38,249 - DEBUG - ydb.query.pool - acquire: Acquired dead session from queue: None
2025-11-01 20:02:38,249 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 1 < 100, will create new one.
2025-11-01 20:02:39,316 - DEBUG - ydb.query.pool - acquire: Acquired dead session from queue: None
2025-11-01 20:02:39,316 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:39,368 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:39,411 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:39,452 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:39,515 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:39,688 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:39,697 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:40,022 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:40,192 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:41,563 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:41,851 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:42,048 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:42,125 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:42,965 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:43,129 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:43,448 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:43,483 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:43,886 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:46,556 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:47,094 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:47,551 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:47,564 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:47,936 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:64916
2025-11-01 20:02:48,056 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:64916". Check endpoint correctness.
2025-11-01 20:02:48,468 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:48,469 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:02:48,469 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:02:49,319 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:50,454 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:50,781 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:51,384 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:57,720 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:58,480 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:64916
2025-11-01 20:02:58,660 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:64916". Check endpoint correctness.
2025-11-01 20:02:59,044 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:59,050 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:02:59,050 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:02:59,483 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:02:59,737 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:03:00,264 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:03:00,264 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:03:00,285 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-01 20:03:00,285 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 9cb7233d-81fe-497e-a114-a18b991b133a, localhost:7640): creating call state
2025-11-01 20:03:00,286 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 9cb7233d-81fe-497e-a114-a18b991b133a, localhost:7640): request = { database: "/Root" }
2025-11-01 20:03:00,289 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 9cb7233d-81fe-497e-a114-a18b991b133a, localhost:7640): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-mjpjznvske.auto.internal" port: 7640 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-11-01 20:03:00,290 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-mjpjznvske.auto.internal:7640, location 1, ssl: False>]>
2025-11-01 20:03:00,290 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:7640
2025-11-01 20:03:00,348 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:03:01,028 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:03:02,654 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:03:02,808 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:03:03,863 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:03:09,054 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:64916
2025-11-01 20:03:09,091 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:64916". Check endpoint correctness.
2025-11-01 20:03:10,654 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:03:10,655 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:03:15,860 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:03:18,984 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:03:19,627 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:03:20,659 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:64916
2025-11-01 20:03:20,848 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:64916". Check endpoint correctness.
2025-11-01 20:03:20,919 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:03:20,922 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:03:20,923 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:03:22,608 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:03:23,569 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:03:24,441 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:03:24,853 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:03:29,591 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:03:30,927 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:64916
2025-11-01 20:03:31,109 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:64916". Check endpoint correctness.
2025-11-01 20:03:32,367 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:03:32,367 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:03:42,380 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:64916
2025-11-01 20:03:42,388 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:64916". Check endpoint correctness.
2025-11-01 20:03:43,407 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:03:43,408 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:03:53,412 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:64916
2025-11-01 20:03:53,440 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:64916". Check endpoint correctness.
2025-11-01 20:03:55,022 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:03:55,023 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:03:57,173 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:03:58,177 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:04:02,760 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:04:05,026 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:64916
2025-11-01 20:04:05,080 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:64916". Check endpoint correctness.
2025-11-01 20:04:06,985 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:04:07,004 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:04:07,172 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:04:08,305 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:04:10,067 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:04:10,068 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:04:10,078 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-01 20:04:10,104 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, deab5f20-0f70-41a9-8352-92dbace9d44a, localhost:7640): creating call state
2025-11-01 20:04:10,104 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, deab5f20-0f70-41a9-8352-92dbace9d44a, localhost:7640): request = { database: "/Root" }
2025-11-01 20:04:10,110 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, deab5f20-0f70-41a9-8352-92dbace9d44a, localhost:7640): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-mjpjznvske.auto.internal" port: 7640 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-11-01 20:04:10,110 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-mjpjznvske.auto.internal:7640, location 1, ssl: False>]>
2025-11-01 20:04:10,111 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:7640
2025-11-01 20:04:10,955 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:04:11,548 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:04:14,226 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:04:17,016 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:64916
2025-11-01 20:04:17,045 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:64916". Check endpoint correctness.
2025-11-01 20:04:18,116 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:04:18,160 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:04:28,170 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:64916
2025-11-01 20:04:28,213 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:64916". Check endpoint correctness.
2025-11-01 20:04:29,419 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:04:29,421 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:04:30,317 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:04:31,439 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:04:39,428 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:64916
2025-11-01 20:04:39,451 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:64916". Check endpoint correctness.
2025-11-01 20:04:41,030 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:04:41,034 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:04:50,833 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:04:51,044 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:64916
2025-11-01 20:04:51,111 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:64916". Check endpoint correctness.
2025-11-01 20:04:51,463 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:04:51,464 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:04:51,516 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:04:53,616 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:05:01,528 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:64916
2025-11-01 20:05:01,580 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:64916". Check endpoint correctness.
2025-11-01 20:05:03,418 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:05:03,419 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:05:03,419 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:05:09,545 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:05:11,729 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:05:13,422 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:64916
2025-11-01 20:05:13,576 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:64916". Check endpoint correctness.
2025-11-01 20:05:14,591 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:05:14,592 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:05:15,239 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:05:15,240 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:05:15,245 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-01 20:05:15,246 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 2eff143d-e835-4fe0-990d-e39cc20556ee, localhost:7640): creating call state
2025-11-01 20:05:15,246 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 2eff143d-e835-4fe0-990d-e39cc20556ee, localhost:7640): request = { database: "/Root" }
2025-11-01 20:05:15,248 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 2eff143d-e835-4fe0-990d-e39cc20556ee, localhost:7640): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-mjpjznvske.auto.internal" port: 7640 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-11-01 20:05:15,249 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-mjpjznvske.auto.internal:7640, location 1, ssl: False>]>
2025-11-01 20:05:15,249 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:7640
2025-11-01 20:05:17,212 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:05:24,595 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:64916
2025-11-01 20:05:24,741 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:64916". Check endpoint correctness.
2025-11-01 20:05:24,886 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:05:24,887 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:05:24,888 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:05:27,597 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:05:29,471 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:05:34,891 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:64916
2025-11-01 20:05:35,037 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:64916". Check endpoint correctness.
2025-11-01 20:05:36,347 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:05:36,348 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:05:46,352 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:64916
2025-11-01 20:05:46,474 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:64916". Check endpoint correctness.
2025-11-01 20:05:47,833 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:05:47,834 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:05:47,834 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:05:51,999 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:05:55,277 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:05:57,838 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:64916
2025-11-01 20:05:58,012 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:64916". Check endpoint correctness.
2025-11-01 20:05:58,077 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:05:58,080 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:05:58,080 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:06:01,944 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:06:08,084 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:64916
2025-11-01 20:06:08,236 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:64916". Check endpoint correctness.
2025-11-01 20:06:09,779 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:06:09,780 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:06:11,586 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:06:13,672 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:06:16,684 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:06:19,788 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:64916
2025-11-01 20:06:19,972 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:64916". Check endpoint correctness.
2025-11-01 20:06:21,760 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:06:21,760 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:06:25,405 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:06:26,536 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:06:31,766 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:64916
2025-11-01 20:06:31,785 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:64916". Check endpoint correctness.
2025-11-01 20:06:33,492 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:06:33,493 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:06:34,708 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:06:34,948 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:06:36,424 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:06:40,880 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:06:43,500 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:64916
2025-11-01 20:06:43,514 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:64916". Check endpoint correctness.
2025-11-01 20:06:44,784 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:06:44,784 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:06:51,170 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-01 20:06:54,788 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:64916
2025-11-01 20:06:54,974 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:64916". Check endpoint correctness.
2025-11-01 20:06:56,806 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:06:56,807 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:06:59,588 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 20:06:59,588 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 20:06:59,594 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-01 20:06:59,594 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 7c1b0310-9b47-49ac-a59b-dee4d42fc801, localhost:7640): creating call state
2025-11-01 20:06:59,597 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 7c1b0310-9b47-49ac-a59b-dee4d42fc801, localhost:7640): request = { database: "/Root" }
2025-11-01 20:06:59,601 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 7c1b0310-9b47-49ac-a59b-dee4d42fc801, localhost:7640): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-mjpjznvske.auto.internal" port: 7640 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-11-01 20:06:59,601 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-mjpjznvske.auto.internal:7640, location 1, ssl: False>]>
2025-11-01 20:06:59,601 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:7640
2025-11-01 20:07:05,698 - ERROR - ya.test - logreport: ydb/tests/olap/test_log_scenario.py:235: in test_log_uniform
    thread.join()
ydb/tests/olap/common/thread_helper.py:18: in join
    raise self.exc
ydb/tests/olap/common/thread_helper.py:11: in run
    self.ret = self._target(*self._args, **self._kwargs)
ydb/tests/olap/test_log_scenario.py:148: in aggregation_query
    self.ydb_client.query(
ydb/tests/olap/common/ydb_client.py:24: in query
    return self.session_pool.execute_with_retries(query=statement, settings=request_settings)
contrib/python/ydb/py3/ydb/query/pool.py:252: in execute_with_retries
    return retry_operation_sync(wrapped_callee, retry_settings)
contrib/python/ydb/py3/ydb/retries.py:135: in retry_operation_sync
    for next_opt in opt_generator:
contrib/python/ydb/py3/ydb/retries.py:130: in retry_operation_impl
    raise status
contrib/python/ydb/py3/ydb/retries.py:96: in retry_operation_impl
    result = YdbRetryOperationFinalResult(callee(*args, **kwargs))
contrib/python/ydb/py3/ydb/query/pool.py:248: in wrapped_callee
    with self.checkout(timeout=retry_settings.max_session_acquire_timeout) as session:
contrib/python/ydb/py3/ydb/query/pool.py:331: in __enter__
    self._session = self._pool.acquire(self._timeout)
contrib/python/ydb/py3/ydb/query/pool.py:111: in acquire
    session = self._create_new_session(time_left)
contrib/python/ydb/py3/ydb/query/pool.py:63: in _create_new_session
    session.create(settings=BaseRequestSettings().with_timeout(timeout))
contrib/python/ydb/py3/ydb/query/session.py:301: in create
    self._create_call(settings=settings)
contrib/python/ydb/py3/ydb/query/session.py:171: in _create_call
    return self._driver(
contrib/python/ydb/py3/ydb/tracing.py:70: in wrapper
    return f(self, *args, **kwargs)
contrib/python/ydb/py3/ydb/pool.py:459: in __call__
    connection = self._store.get(preferred_endpoint)
contrib/python/ydb/py3/ydb/tracing.py:70: in wrapper
    return f(self, *args, **kwargs)
contrib/python/ydb/py3/ydb/pool.py:144: in get
    raise issues.ConnectionLost("Couldn't find valid connection")
E   ydb.issues.ConnectionLost: Couldn't find valid connection
2025-11-01 20:07:05,701 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-11-01 20:07:05,701 - DEBUG - ydb.query.pool - stop: All session were deleted.
2025-11-01 20:07:05,702 - DEBUG - ydb.topic - close: Close topic client
2025-11-01 20:07:05,702 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-01 20:07:05,702 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:64916
2025-11-01 20:07:06,810 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:64916
2025-11-01 20:07:06,958 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:64916". Check endpoint correctness.
2025-11-01 20:07:06,958 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-11-01 20:07:06,959 - DEBUG - library.python.cores - recover_core_dump_file: hostname = 'ghrun-mjpjznvske'
2025-11-01 20:07:06,961 - DEBUG - library.python.cores - recover_core_dump_file: rlimit_core = '(0, -1)'
2025-11-01 20:07:06,961 - DEBUG - library.python.cores - recover_core_dump_file: core_pattern = '|/usr/share/apport/apport -p%p -s%s -c%c -d%d -P%P -u%u -g%g -F%F -- %E'
2025-11-01 20:07:06,962 - DEBUG - library.python.cores - recover_core_dump_file: core_uses_pid = '1'
2025-11-01 20:07:06,963 - DEBUG - library.python.cores - recover_core_dump_file: Core dump dir (/home/runner/.ya/build/build_root/vv82/002f47/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk3/testing_out_stuff/test_log_scenario.py.TestLogScenario.test_log_deviation.1051200/cluster/node_1) permission mask: 0o40755 (expected: 0o41777 (0o40000-dir, 0o1000-sticky bit))
2025-11-01 20:07:06,963 - DEBUG - library.python.cores - recover_core_dump_file: Search for core dump files match pattern 'core.3307383' in '/home/runner/.ya/build/build_root/vv82/002f47/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk3/testing_out_stuff/test_log_scenario.py.TestLogScenario.test_log_deviation.1051200/cluster/node_1'
2025-11-01 20:07:06,964 - DEBUG - library.python.cores - recover_core_dump_file: Matched core dump files (0/3): [] (mismatched samples: stderr, stdout, logfile_ezztiaz2.log)
2025-11-01 20:07:06,964 - WARNING - library.python.cores - recover_core_dump_file: Core dump dir doesn't exist: /coredumps
2025-11-01 20:07:06,964 - WARNING - library.python.cores - recover_core_dump_file: Core dump dir doesn't exist: /var/tmp/cores
2025-11-01 20:07:06,965 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:64916/1
2025-11-01 20:07:06,965 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/30283
2025-11-01 20:07:06,966 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/6555
2025-11-01 20:07:06,966 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/15071
2025-11-01 20:07:06,967 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/64916
2025-11-01 20:07:06,967 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/28520
2025-11-01 20:07:07,062 - ERROR - ya.test - logreport: ydb/tests/olap/test_log_scenario.py:123: in teardown_class
    cls.cluster.stop()
ydb/tests/library/harness/kikimr_runner.py:694: in stop
    raise daemon.SeveralDaemonErrors(saved_exceptions)
E   ydb.tests.library.harness.daemon.SeveralDaemonErrors: Daemon failed with message: Unexpectedly finished before stop.
E   Process exit_code = -6.
E   Stdout file name: 
E   /home/runner/.ya/build/build_root/vv82/002f47/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk3/testing_out_stuff/test_log_scenario.py.TestLogScenario.test_log_deviation.1051200/cluster/node_1/stdout
E   Stderr file name: 
E   /home/runner/.ya/build/build_root/vv82/002f47/ydb/tests/olap/test-results/py3test/testing_out_stuff/chunk3/testing_out_stuff/test_log_scenario.py.TestLogScenario.test_log_deviation.1051200/cluster/node_1/stderr
E   Stderr content:
E   
E   GRpc memory quota was set but disabled due to issues with grpc quoter, to enable it use EnableGRpcMemoryQuota option
E   VERIFY failed (2025-11-01T20:02:29.650742Z): tablet_id=72075186224037974;self_id=[1:7567849577632994931:13017];ev=NKikimr::TEvDataShard::TEvCancelTransactionProposal;tx_id=281474976714179;lock_id=281474976714144;verification=!CommitSnapshot;fline=written.h:108;
E   ydb/library/actors/core/log.cpp:857
E   ~TVerifyFormattedRecordWriter(): requirement false failed
E   0. /-S/util/system/yassert.cpp:86: InternalPanicImpl @ 0xA61CBC5
E   1. /-S/util/system/yassert.cpp:55: Panic @ 0xA615106
E   2. /tmp//-S/ydb/library/actors/core/log.cpp:857: ~TVerifyFormattedRecordWriter @ 0xB4A1EA8
E   3. /-S/ydb/core/tx/columnshard/engines/portions/written.h:0: SetCommitSnapshot @ 0x167BC676
E   4. /-S/ydb/core/tx/columnshard/engines/storage/granule/granule.h:228: AbortPortionOnExecute @ 0x16AD8271
E   5. /tmp//-S/ydb/core/tx/columnshard/operations/write.cpp:130: AbortOnExecute @ 0x16AD8084
E   6. /tmp//-S/ydb/core/tx/columnshard/operations/manager.cpp:134: AbortTransactionOnExecute @ 0x16AD009E
E   7. /-S/ydb/core/tx/columnshard/transactions/operators/ev_write/abstract.h:116: ExecuteOnAbort @ 0x9FB3D7C
E   8. /tmp//-S/ydb/core/tx/columnshard/transactions/tx_controller.cpp:185: ExecuteOnCancel @ 0x16AF968C
E   9. /tmp//-S/ydb/core/tx/columnshard/columnshard__propose_cancel.cpp:22: Execute @ 0x16B5DBBE
E   10. /tmp//-S/ydb/core/tablet_flat/flat_executor.cpp:2032: ExecuteTransaction @ 0xCF81296
E   11. /tmp//-S/ydb/core/tablet_flat/flat_executor.cpp:1937: DoExecute @ 0xCF7F25E
E   12. /tmp//-S/ydb/core/tablet_flat/flat_executor.cpp:1951: Execute @ 0xCF825DE
E   13. /tmp//-S/ydb/core/tablet_flat/tablet_flat_executed.cpp:62: Execute @ 0xCF5B3D6
E   14. /tmp//-S/ydb/core/tablet_flat/tablet_flat_executed.cpp:57: Execute @ 0xCF5B3D6
E   15. /tmp//-S/ydb/core/tx/columnshard/columnshard__propose_cancel.cpp:38: Handle @ 0x16B5D2F9
E   16. /-S/ydb/core/tx/columnshard/columnshard_impl.h:424: StateWork @ 0x16B250D8
E   17. /tmp//-S/ydb/library/actors/core/actor.cpp:350: Receive @ 0xB44DD57
E   18. /tmp//-S/ydb/library/actors/core/executor_thread.cpp:267: Execute @ 0xB492954
E   19. /tmp//-S/ydb/library/actors/core/executor_thread.cpp:455: operator() @ 0xB496A14
E   20. /tmp//-S/ydb/library/actors/core/executor_thread.cpp:507: ProcessExecutorPool @ 0xB496620
E   21. /tmp//-S/ydb/library/actors/core/executor_thread.cpp:533: ThreadProc @ 0xB49720E
E   22. /-S/util/system/thread.cpp:245: ThreadProxy @ 0xA61E81C
E   23. ??:0: ?? @ 0x7F56BECB2AC2
E   24. ??:0: ?? @ 0x7F56BED448BF
2025-11-01 20:07:09,513 - ERROR - ydb.query.pool - acquire: An attempt to take session from closed session pool.
2025-11-01 20:07:54,122 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/vv82/002f47/ydb/apps/ydb/ydb', '-e', 'grpc://localhost:64916', '-d', '/Root', 'workload', 'log', '--path', 'log', 'clean']' in 'None' (waiting)
2025-11-01 20:07:54,123 - DEBUG - ya.test - execute: Command pid: 3553850
2025-11-01 20:07:54,236 - DEBUG - ya.test - _kill_process_tree: Killing process 3553850
2025-11-01 20:07:54,236 - DEBUG - ya.test - _nix_kill_process_tree: Killing process tree for pid 3553850 (bin:'error([Errno 2] No such file or directory: '/proc/3553850/exe')')
2025-11-01 20:07:54,237 - DEBUG - ya.test - try_to_send_signal: Error while sending signal 19 to pid 3553850: [Errno 3] No such process
2025-11-01 20:07:54,237 - DEBUG - ya.test - try_to_send_signal: Error while sending signal 9 to pid 3553850: [Errno 3] No such process
2025-11-01 20:07:54,237 - DEBUG - ya.test - try_to_send_signal: Error while sending signal 18 to pid 3553850: [Errno 3] No such process
2025-11-01 20:07:54,237 - DEBUG - ya.test - _wait: Process resource usage is not available as process finished before wait4 was called
2025-11-01 20:07:54,237 - DEBUG - ya.test - wait: Command exception: sys.meta_path is None, Python is likely shutting down
2025-11-01 20:07:54,238 - DEBUG - ya.test - _save_outputs: Command (pid 3553850) rc: 0
2025-11-01 20:07:54,238 - DEBUG - ya.test - _save_outputs: Command (pid 3553850) elapsed time (sec): 0.11387419700622559
2025-11-01 20:07:54,238 - DEBUG - ya.test - _save_outputs: Command (pid 3553850) wtime: 0.115
2025-11-01 20:07:54,238 - DEBUG - ya.test - _save_outputs: Command (pid 3553850) output:
Remove path log...

2025-11-01 20:07:54,238 - DEBUG - ya.test - _save_outputs: Command (pid 3553850) errors:
Status: TRANSPORT_UNAVAILABLE
Issues: 
<main>: Error: GRpc error: (14): connections to all backends failing; last error: UNKNOWN: ipv4:127.0.0.1:64916: Failed to connect to remote host: Connection refused
<main>: Error: Grpc error response on endpoint localhost:64916
<main>: Error: Endpoint list is empty for database /Root, cluster endpoint localhost:64916.

