2025-10-14 14:44:49,431 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-14 14:44:49,431 - INFO - ya.test - pytest_runtest_setup: test_read_topic_shared_reading_limit
2025-10-14 14:44:49,432 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-14 14:44:49,440 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-14 14:44:49,442 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_streaming.py::TestStreamingInYdb, test_name: test_read_topic_shared_reading_limit)
2025-10-14 14:44:49,444 - DEBUG - root - create_stream: Requesting CreateStream.
Database: "local".
Request:
stream_name: "/local/test_read_topic_shared_reading_input"
shard_count: 10
write_quota_kb_per_sec: 1024
retention_period_hours: 1

2025-10-14 14:44:49,734 - DEBUG - root - _get_and_check_result: Response: operation {
  ready: true
  status: SUCCESS
}

2025-10-14 14:44:49,735 - DEBUG - root - _get_and_check_result: Result: 
2025-10-14 14:44:49,736 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YWM4NWY0NDItNDFhMjgxNy1kMDA5YTBlYy0xNmYxOGY2Mg==
2025-10-14 14:44:49,737 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, bc3af09a-a2f2-4726-984c-62edc6b108af, ghrun-z7hi2c47em.auto.internal:17398): creating call state
2025-10-14 14:44:49,738 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, bc3af09a-a2f2-4726-984c-62edc6b108af, ghrun-z7hi2c47em.auto.internal:17398): request = { session_id: "ydb://session/3?node_id=1&id=YWM4NWY0NDItNDFhMjgxNy1kMDA5YTBlYy0xNmYxOGY2Mg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            CREATE EXTERNAL DATA SOURCE `sourceName2` WITH (\n                SOURCE_TYPE=\"Ydb\",\n                LOCATION=\"localhost:4104\",\n                DATABASE_NAME=\"local\",\n                SHARED_READING=\"TRUE\",\n                AUTH_METHOD=\"NONE\");" } stats_mode: STATS_MODE_NONE }
2025-10-14 14:44:49,745 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, bc3af09a-a2f2-4726-984c-62edc6b108af, ghrun-z7hi2c47em.auto.internal:17398): response = { <_MultiThreadedRendezvous object> }
2025-10-14 14:44:49,844 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YWM4NWY0NDItNDFhMjgxNy1kMDA5YTBlYy0xNmYxOGY2Mg==
2025-10-14 14:44:49,848 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YWM4NWY0NDItNDFhMjgxNy1kMDA5YTBlYy0xNmYxOGY2Mg==
2025-10-14 14:44:49,850 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6ee86d31-bae0-4d09-95a0-c7c6e92c94a1, ghrun-z7hi2c47em.auto.internal:8333): creating call state
2025-10-14 14:44:49,850 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6ee86d31-bae0-4d09-95a0-c7c6e92c94a1, ghrun-z7hi2c47em.auto.internal:8333): request = { session_id: "ydb://session/3?node_id=1&id=YWM4NWY0NDItNDFhMjgxNy1kMDA5YTBlYy0xNmYxOGY2Mg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT time FROM sourceName2.`test_read_topic_shared_reading_input`\n            WITH (\n                FORMAT=\"json_each_row\",\n                SCHEMA=(time String NOT NULL))\n            WHERE time like \"%lunch%\"\n            LIMIT 1" } stats_mode: STATS_MODE_NONE }
2025-10-14 14:44:49,852 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6ee86d31-bae0-4d09-95a0-c7c6e92c94a1, ghrun-z7hi2c47em.auto.internal:8333): response = { <_MultiThreadedRendezvous object> }
2025-10-14 14:44:49,857 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 1 < 100, will create new one.
2025-10-14 14:44:49,858 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, a2670462-38f3-41f5-a97c-e969353a2c4a, ghrun-z7hi2c47em.auto.internal:17398): creating call state
2025-10-14 14:44:49,859 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, a2670462-38f3-41f5-a97c-e969353a2c4a, ghrun-z7hi2c47em.auto.internal:17398): request = {  }
2025-10-14 14:44:49,869 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, a2670462-38f3-41f5-a97c-e969353a2c4a, ghrun-z7hi2c47em.auto.internal:17398): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=NTY3Zjg1ZWQtZmM1ZDEyMzAtZTk4YjYxNzMtN2I5YzJjYjA=" node_id: 1 }
2025-10-14 14:44:49,871 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, 1f105dea-aa95-4b5c-b580-25d62fe87c68, ghrun-z7hi2c47em.auto.internal:8333): creating call state
2025-10-14 14:44:49,872 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, 1f105dea-aa95-4b5c-b580-25d62fe87c68, ghrun-z7hi2c47em.auto.internal:8333): request = { session_id: "ydb://session/3?node_id=1&id=NTY3Zjg1ZWQtZmM1ZDEyMzAtZTk4YjYxNzMtN2I5YzJjYjA=" }
2025-10-14 14:44:49,873 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, 1f105dea-aa95-4b5c-b580-25d62fe87c68, ghrun-z7hi2c47em.auto.internal:8333): response = { <_MultiThreadedRendezvous object> }
2025-10-14 14:44:49,901 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=NTY3Zjg1ZWQtZmM1ZDEyMzAtZTk4YjYxNzMtN2I5YzJjYjA=
2025-10-14 14:44:49,902 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9e8f3055-82f8-42d5-a132-02e36767846a, ghrun-z7hi2c47em.auto.internal:17398): creating call state
2025-10-14 14:44:49,903 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9e8f3055-82f8-42d5-a132-02e36767846a, ghrun-z7hi2c47em.auto.internal:17398): request = { session_id: "ydb://session/3?node_id=1&id=NTY3Zjg1ZWQtZmM1ZDEyMzAtZTk4YjYxNzMtN2I5YzJjYjA=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT time FROM sourceName2.`test_read_topic_shared_reading_input`\n            WITH (\n                FORMAT=\"json_each_row\",\n                SCHEMA=(time String NOT NULL))\n            WHERE time like \"%lunch%\"\n            LIMIT 1" } stats_mode: STATS_MODE_NONE }
2025-10-14 14:44:49,913 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9e8f3055-82f8-42d5-a132-02e36767846a, ghrun-z7hi2c47em.auto.internal:17398): response = { <_MultiThreadedRendezvous object> }
2025-10-14 14:44:52,889 - DEBUG - root - write_stream: Write topic test_read_topic_shared_reading_input. Response: operation {
  ready: true
  status: SUCCESS
  result {
    type_url: "type.googleapis.com/Ydb.DataStreams.V1.PutRecordsResult"
    value: "\010\001\032\021\"\0010*\014shard-000008"
  }
}

2025-10-14 14:44:52,890 - INFO - root - write_stream: Data was written to test_read_topic_shared_reading_input: ['{"time": "lunch time"}']
2025-10-14 14:44:53,896 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YWM4NWY0NDItNDFhMjgxNy1kMDA5YTBlYy0xNmYxOGY2Mg==
2025-10-14 14:46:47,112 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-14 14:46:47,113 - 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-10-14 14:46:47,132 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-10-14 14:46:47,133 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, a5ea17b4-9690-4ce1-ad54-0905c38f56fa, localhost:17398): creating call state
2025-10-14 14:46:47,134 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, a5ea17b4-9690-4ce1-ad54-0905c38f56fa, localhost:17398): request = { database: "/Root" }
2025-10-14 14:46:47,146 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, a5ea17b4-9690-4ce1-ad54-0905c38f56fa, localhost:17398): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-z7hi2c47em.auto.internal" port: 8333 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: 2 } endpoints { address: "ghrun-z7hi2c47em.auto.internal" port: 17398 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-10-14 14:46:47,148 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-z7hi2c47em.auto.internal:17398, location 1, ssl: False>, <Endpoint ghrun-z7hi2c47em.auto.internal:8333, location 1, ssl: False>]>
2025-10-14 14:46:47,154 - INFO - ydb.connection - close: Closing channel for endpoint localhost:17398
2025-10-14 14:48:15,320 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-14 14:48:15,321 - 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-10-14 14:48:15,331 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-10-14 14:48:15,331 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, a87d4a97-acc9-47fb-9413-ba3060aa1d00, localhost:17398): creating call state
2025-10-14 14:48:15,332 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, a87d4a97-acc9-47fb-9413-ba3060aa1d00, localhost:17398): request = { database: "/Root" }
2025-10-14 14:48:15,345 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, a87d4a97-acc9-47fb-9413-ba3060aa1d00, localhost:17398): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-z7hi2c47em.auto.internal" port: 8333 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: 2 } endpoints { address: "ghrun-z7hi2c47em.auto.internal" port: 17398 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-10-14 14:48:15,346 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-z7hi2c47em.auto.internal:17398, location 1, ssl: False>, <Endpoint ghrun-z7hi2c47em.auto.internal:8333, location 1, ssl: False>]>
2025-10-14 14:48:15,347 - INFO - ydb.connection - close: Closing channel for endpoint localhost:17398
2025-10-14 14:49:31,347 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-14 14:49:31,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-10-14 14:49:31,377 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-10-14 14:49:31,378 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 755dc2ab-e663-4a39-9068-284d06ec7b40, localhost:17398): creating call state
2025-10-14 14:49:31,379 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 755dc2ab-e663-4a39-9068-284d06ec7b40, localhost:17398): request = { database: "/Root" }
2025-10-14 14:49:31,395 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 755dc2ab-e663-4a39-9068-284d06ec7b40, localhost:17398): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-z7hi2c47em.auto.internal" port: 8333 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: 2 } endpoints { address: "ghrun-z7hi2c47em.auto.internal" port: 17398 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-10-14 14:49:31,396 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-z7hi2c47em.auto.internal:8333, location 1, ssl: False>, <Endpoint ghrun-z7hi2c47em.auto.internal:17398, location 1, ssl: False>]>
2025-10-14 14:49:31,397 - INFO - ydb.connection - close: Closing channel for endpoint localhost:17398
2025-10-14 14:51:28,324 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-14 14:51:28,324 - 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-10-14 14:51:28,338 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-10-14 14:51:28,339 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 8e26bb93-c432-445f-bd01-b068f8827dda, localhost:17398): creating call state
2025-10-14 14:51:28,339 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 8e26bb93-c432-445f-bd01-b068f8827dda, localhost:17398): request = { database: "/Root" }
2025-10-14 14:51:28,347 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 8e26bb93-c432-445f-bd01-b068f8827dda, localhost:17398): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-z7hi2c47em.auto.internal" port: 8333 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: 2 } endpoints { address: "ghrun-z7hi2c47em.auto.internal" port: 17398 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-10-14 14:51:28,349 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-z7hi2c47em.auto.internal:17398, location 1, ssl: False>, <Endpoint ghrun-z7hi2c47em.auto.internal:8333, location 1, ssl: False>]>
2025-10-14 14:51:28,349 - INFO - ydb.connection - close: Closing channel for endpoint localhost:17398
2025-10-14 14:52:59,297 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-14 14:52:59,298 - 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-10-14 14:52:59,307 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-10-14 14:52:59,308 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, ac9733da-d08e-4406-a199-26bfe13a396e, localhost:17398): creating call state
2025-10-14 14:52:59,309 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, ac9733da-d08e-4406-a199-26bfe13a396e, localhost:17398): request = { database: "/Root" }
2025-10-14 14:52:59,317 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, ac9733da-d08e-4406-a199-26bfe13a396e, localhost:17398): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-z7hi2c47em.auto.internal" port: 8333 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: 2 } endpoints { address: "ghrun-z7hi2c47em.auto.internal" port: 17398 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-10-14 14:52:59,319 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-z7hi2c47em.auto.internal:17398, location 1, ssl: False>, <Endpoint ghrun-z7hi2c47em.auto.internal:8333, location 1, ssl: False>]>
2025-10-14 14:52:59,319 - INFO - ydb.connection - close: Closing channel for endpoint localhost:17398
2025-10-14 14:54:38,909 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-14 14:54:38,910 - 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-10-14 14:54:38,921 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-10-14 14:54:38,921 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, b05f06b3-2399-42f8-8a11-66898b1469d5, localhost:17398): creating call state
2025-10-14 14:54:38,922 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, b05f06b3-2399-42f8-8a11-66898b1469d5, localhost:17398): request = { database: "/Root" }
2025-10-14 14:54:38,931 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, b05f06b3-2399-42f8-8a11-66898b1469d5, localhost:17398): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-z7hi2c47em.auto.internal" port: 8333 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: 2 } endpoints { address: "ghrun-z7hi2c47em.auto.internal" port: 17398 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-10-14 14:54:38,932 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-z7hi2c47em.auto.internal:17398, location 1, ssl: False>, <Endpoint ghrun-z7hi2c47em.auto.internal:8333, location 1, ssl: False>]>
2025-10-14 14:54:38,933 - INFO - ydb.connection - close: Closing channel for endpoint localhost:17398
2025-10-14 14:54:49,908 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NTY3Zjg1ZWQtZmM1ZDEyMzAtZTk4YjYxNzMtN2I5YzJjYjA=
2025-10-14 14:54:49,911 - DEBUG - ydb.connection - _prepare_call: RpcState(DeleteSession, dbfd7ea1-960a-4840-a20a-b9fa81df8fbe, ghrun-z7hi2c47em.auto.internal:8333): creating call state
2025-10-14 14:54:49,920 - DEBUG - ydb.connection - _log_request: RpcState(DeleteSession, dbfd7ea1-960a-4840-a20a-b9fa81df8fbe, ghrun-z7hi2c47em.auto.internal:8333): request = { session_id: "ydb://session/3?node_id=1&id=YWM4NWY0NDItNDFhMjgxNy1kMDA5YTBlYy0xNmYxOGY2Mg==" }
2025-10-14 14:54:49,940 - DEBUG - ydb.connection - _log_response: RpcState(DeleteSession, dbfd7ea1-960a-4840-a20a-b9fa81df8fbe, ghrun-z7hi2c47em.auto.internal:8333): response = { status: SUCCESS }
2025-10-14 14:54:49,962 - DEBUG - ydb.connection - _prepare_call: RpcState(DeleteSession, 25efaaa9-b3fa-44c8-b6e7-7ada27975d4e, ghrun-z7hi2c47em.auto.internal:17398): creating call state
2025-10-14 14:54:49,962 - DEBUG - ydb.connection - _log_request: RpcState(DeleteSession, 25efaaa9-b3fa-44c8-b6e7-7ada27975d4e, ghrun-z7hi2c47em.auto.internal:17398): request = { session_id: "ydb://session/3?node_id=1&id=NTY3Zjg1ZWQtZmM1ZDEyMzAtZTk4YjYxNzMtN2I5YzJjYjA=" }
2025-10-14 14:54:49,971 - DEBUG - ydb.connection - _log_response: RpcState(DeleteSession, 25efaaa9-b3fa-44c8-b6e7-7ada27975d4e, ghrun-z7hi2c47em.auto.internal:17398): response = { status: SUCCESS }
2025-10-14 14:54:49,975 - DEBUG - ydb.query.pool - stop: All session were deleted.
2025-10-14 14:54:49,978 - DEBUG - ydb.topic - close: Close topic client
2025-10-14 14:54:49,986 - DEBUG - ydb.topic - close: Topic client was closed
2025-10-14 14:54:49,994 - INFO - ydb.connection - close: Closing channel for endpoint localhost:17398
2025-10-14 14:54:49,995 - INFO - ydb.connection - close: Closing channel for endpoint ghrun-z7hi2c47em.auto.internal:17398
2025-10-14 14:54:50,000 - INFO - ydb.connection - close: Closing channel for endpoint ghrun-z7hi2c47em.auto.internal:8333
2025-10-14 14:54:50,006 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-10-14 14:54:57,015 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:17398/1
2025-10-14 14:54:57,016 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:8333/2
2025-10-14 14:54:57,017 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/4627
2025-10-14 14:54:57,018 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/25113
2025-10-14 14:54:57,021 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/63946
2025-10-14 14:54:57,022 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/8333
2025-10-14 14:54:57,022 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/25935
2025-10-14 14:54:57,023 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/24090
2025-10-14 14:54:57,023 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/2032
2025-10-14 14:54:57,023 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/17398
2025-10-14 14:54:57,024 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/4842
2025-10-14 14:54:57,024 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/30761
