2026-03-25 17:14:46,518 - INFO - ya.test.2480905  - pytest_runtest_setup: ####################################################################################################
2026-03-25 17:14:46,518 - INFO - ya.test.2480905  - pytest_runtest_setup: test_too_many_pending_transactions
2026-03-25 17:14:46,519 - INFO - ya.test.2480905  - pytest_runtest_setup: ####################################################################################################
2026-03-25 17:14:46,519 - INFO - ya.test.2480905  - pytest_runtest_setup: Test setup
2026-03-25 17:14:46,519 - INFO - ya.test.2480905  - pytest_runtest_call: Test call (class_name: test_public_api.py::TestCRUDOperations, test_name: test_too_many_pending_transactions)
2026-03-25 17:14:46,520 - DEBUG - ydb.connection.2480905  - 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', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2026-03-25 17:14:46,521 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2480905  - context_resolve: Preparing initial endpoint to resolve endpoints
2026-03-25 17:14:46,522 - DEBUG - ydb.connection.2480905  - 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', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2026-03-25 17:14:46,526 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2480905  - context_resolve: Resolving endpoints for database /Root
2026-03-25 17:14:46,526 - DEBUG - ydb.connection.2480905  - _prepare_call: RpcState(ListEndpoints, 9d6300f2-46f0-4d38-924d-fbfe0660dd3d, localhost:19531): creating call state
2026-03-25 17:14:46,527 - DEBUG - ydb.connection.2480905  - _log_request: RpcState(ListEndpoints, 9d6300f2-46f0-4d38-924d-fbfe0660dd3d, localhost:19531): request = { database: "/Root" }
2026-03-25 17:14:46,529 - DEBUG - ydb.connection.2480905  - _log_response: RpcState(ListEndpoints, 9d6300f2-46f0-4d38-924d-fbfe0660dd3d, localhost:19531): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-ve2ie6ihly.auto.internal" port: 19531 service: "nbs" 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" } } } }
2026-03-25 17:14:46,529 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2480905  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-ve2ie6ihly.auto.internal:19531, location 1, ssl: False>]>
2026-03-25 17:14:46,529 - DEBUG - ydb.connection.2480905  - 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', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2026-03-25 17:14:46,535 - DEBUG - ydb.connection.2480905  - close: Closing channel for endpoint localhost:19531
2026-03-25 17:14:46,536 - DEBUG - ydb.connection.2480905  - _prepare_call: RpcState(CreateSession, 352829a5-f758-4a5c-968c-f6f0392d77c3, ghrun-ve2ie6ihly.auto.internal:19531): creating call state
2026-03-25 17:14:46,536 - DEBUG - ydb.connection.2480905  - _log_request: RpcState(CreateSession, 352829a5-f758-4a5c-968c-f6f0392d77c3, ghrun-ve2ie6ihly.auto.internal:19531): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2026-03-25 17:14:46,538 - DEBUG - ydb.connection.2480905  - _log_response: RpcState(CreateSession, 352829a5-f758-4a5c-968c-f6f0392d77c3, ghrun-ve2ie6ihly.auto.internal:19531): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=MWU5MDU3MjMtOTA0ZGZlYy0zZGQ4Yjg0My1mNjJhNWMxNA%3D%3D" } } } }
2026-03-25 17:14:46,539 - DEBUG - ydb.connection.2480905  - _prepare_call: RpcState(BeginTransaction, fe62402a-8941-4c6b-ab3d-30ea95a1beac, ghrun-ve2ie6ihly.auto.internal:19531): creating call state
2026-03-25 17:14:46,539 - DEBUG - ydb.connection.2480905  - _log_request: RpcState(BeginTransaction, fe62402a-8941-4c6b-ab3d-30ea95a1beac, ghrun-ve2ie6ihly.auto.internal:19531): request = { session_id: "ydb://session/3?node_id=1&id=MWU5MDU3MjMtOTA0ZGZlYy0zZGQ4Yjg0My1mNjJhNWMxNA%3D%3D" tx_settings { serializable_read_write { } } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2026-03-25 17:14:46,541 - DEBUG - ydb.connection.2480905  - _log_response: RpcState(BeginTransaction, fe62402a-8941-4c6b-ab3d-30ea95a1beac, ghrun-ve2ie6ihly.auto.internal:19531): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.BeginTransactionResult] { tx_meta { id: "01kmjzvpccfe7vzvww0snsdnv1" } } } } }
2026-03-25 17:14:46,541 - DEBUG - ydb.connection.2480905  - _prepare_call: RpcState(BeginTransaction, 244d2bb9-acc6-48e3-aa97-57a20376d912, ghrun-ve2ie6ihly.auto.internal:19531): creating call state
2026-03-25 17:14:46,541 - DEBUG - ydb.connection.2480905  - _log_request: RpcState(BeginTransaction, 244d2bb9-acc6-48e3-aa97-57a20376d912, ghrun-ve2ie6ihly.auto.internal:19531): request = { session_id: "ydb://session/3?node_id=1&id=MWU5MDU3MjMtOTA0ZGZlYy0zZGQ4Yjg0My1mNjJhNWMxNA%3D%3D" tx_settings { serializable_read_write { } } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2026-03-25 17:14:46,543 - DEBUG - ydb.connection.2480905  - _log_response: RpcState(BeginTransaction, 244d2bb9-acc6-48e3-aa97-57a20376d912, ghrun-ve2ie6ihly.auto.internal:19531): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.BeginTransactionResult] { tx_meta { id: "01kmjzvpce1bbh16shb56sf9nt" } } } } }
2026-03-25 17:14:46,543 - DEBUG - ydb.connection.2480905  - _prepare_call: RpcState(BeginTransaction, b46b08a6-cf87-4d2a-a4e0-8a3f206d6f8b, ghrun-ve2ie6ihly.auto.internal:19531): creating call state
2026-03-25 17:14:46,544 - DEBUG - ydb.connection.2480905  - _log_request: RpcState(BeginTransaction, b46b08a6-cf87-4d2a-a4e0-8a3f206d6f8b, ghrun-ve2ie6ihly.auto.internal:19531): request = { session_id: "ydb://session/3?node_id=1&id=MWU5MDU3MjMtOTA0ZGZlYy0zZGQ4Yjg0My1mNjJhNWMxNA%3D%3D" tx_settings { serializable_read_write { } } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2026-03-25 17:14:46,545 - DEBUG - ydb.connection.2480905  - _log_response: RpcState(BeginTransaction, b46b08a6-cf87-4d2a-a4e0-8a3f206d6f8b, ghrun-ve2ie6ihly.auto.internal:19531): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.BeginTransactionResult] { tx_meta { id: "01kmjzvpcg3qpb3gtcs771d69e" } } } } }
2026-03-25 17:14:46,545 - DEBUG - ydb.connection.2480905  - _prepare_call: RpcState(BeginTransaction, a2c554c5-7e0b-4685-b1bd-2d20f4010915, ghrun-ve2ie6ihly.auto.internal:19531): creating call state
2026-03-25 17:14:46,546 - DEBUG - ydb.connection.2480905  - _log_request: RpcState(BeginTransaction, a2c554c5-7e0b-4685-b1bd-2d20f4010915, ghrun-ve2ie6ihly.auto.internal:19531): request = { session_id: "ydb://session/3?node_id=1&id=MWU5MDU3MjMtOTA0ZGZlYy0zZGQ4Yjg0My1mNjJhNWMxNA%3D%3D" tx_settings { serializable_read_write { } } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2026-03-25 17:14:46,547 - DEBUG - ydb.connection.2480905  - _log_response: RpcState(BeginTransaction, a2c554c5-7e0b-4685-b1bd-2d20f4010915, ghrun-ve2ie6ihly.auto.internal:19531): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.BeginTransactionResult] { tx_meta { id: "01kmjzvpckex4e8d8x4v4r60p2" } } } } }
2026-03-25 17:14:46,548 - DEBUG - ydb.connection.2480905  - _prepare_call: RpcState(BeginTransaction, 1bb9c42c-fb2b-43f6-a6c6-ee87258ac7a3, ghrun-ve2ie6ihly.auto.internal:19531): creating call state
2026-03-25 17:14:46,548 - DEBUG - ydb.connection.2480905  - _log_request: RpcState(BeginTransaction, 1bb9c42c-fb2b-43f6-a6c6-ee87258ac7a3, ghrun-ve2ie6ihly.auto.internal:19531): request = { session_id: "ydb://session/3?node_id=1&id=MWU5MDU3MjMtOTA0ZGZlYy0zZGQ4Yjg0My1mNjJhNWMxNA%3D%3D" tx_settings { serializable_read_write { } } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2026-03-25 17:14:46,549 - DEBUG - ydb.connection.2480905  - _log_response: RpcState(BeginTransaction, 1bb9c42c-fb2b-43f6-a6c6-ee87258ac7a3, ghrun-ve2ie6ihly.auto.internal:19531): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.BeginTransactionResult] { tx_meta { id: "01kmjzvpcn3w8zsrj0nmdz21c8" } } } } }
2026-03-25 17:14:46,550 - DEBUG - ydb.connection.2480905  - _prepare_call: RpcState(BeginTransaction, 7a4d4808-cdfd-4de1-a2eb-5a478b8b69df, ghrun-ve2ie6ihly.auto.internal:19531): creating call state
2026-03-25 17:14:46,550 - DEBUG - ydb.connection.2480905  - _log_request: RpcState(BeginTransaction, 7a4d4808-cdfd-4de1-a2eb-5a478b8b69df, ghrun-ve2ie6ihly.auto.internal:19531): request = { session_id: "ydb://session/3?node_id=1&id=MWU5MDU3MjMtOTA0ZGZlYy0zZGQ4Yjg0My1mNjJhNWMxNA%3D%3D" tx_settings { serializable_read_write { } } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2026-03-25 17:14:46,551 - DEBUG - ydb.connection.2480905  - _log_response: RpcState(BeginTransaction, 7a4d4808-cdfd-4de1-a2eb-5a478b8b69df, ghrun-ve2ie6ihly.auto.internal:19531): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.BeginTransactionResult] { tx_meta { id: "01kmjzvpcp7d21zb4qrmdc81h1" } } } } }
2026-03-25 17:14:46,551 - DEBUG - ydb.connection.2480905  - _prepare_call: RpcState(BeginTransaction, fd61e6d0-9697-429e-b778-949a16905c0c, ghrun-ve2ie6ihly.auto.internal:19531): creating call state
2026-03-25 17:14:46,552 - DEBUG - ydb.connection.2480905  - _log_request: RpcState(BeginTransaction, fd61e6d0-9697-429e-b778-949a16905c0c, ghrun-ve2ie6ihly.auto.internal:19531): request = { session_id: "ydb://session/3?node_id=1&id=MWU5MDU3MjMtOTA0ZGZlYy0zZGQ4Yjg0My1mNjJhNWMxNA%3D%3D" tx_settings { serializable_read_write { } } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2026-03-25 17:14:46,553 - DEBUG - ydb.connection.2480905  - _log_response: RpcState(BeginTransaction, fd61e6d0-9697-429e-b778-949a16905c0c, ghrun-ve2ie6ihly.auto.internal:19531): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.BeginTransactionResult] { tx_meta { id: "01kmjzvpcs75b7zez4kd25vk6n" } } } } }
2026-03-25 17:14:46,554 - DEBUG - ydb.connection.2480905  - _prepare_call: RpcState(BeginTransaction, 3b9e4883-4d97-47b2-9633-20140e6af941, ghrun-ve2ie6ihly.auto.internal:19531): creating call state
2026-03-25 17:14:46,554 - DEBUG - ydb.connection.2480905  - _log_request: RpcState(BeginTransaction, 3b9e4883-4d97-47b2-9633-20140e6af941, ghrun-ve2ie6ihly.auto.internal:19531): request = { session_id: "ydb://session/3?node_id=1&id=MWU5MDU3MjMtOTA0ZGZlYy0zZGQ4Yjg0My1mNjJhNWMxNA%3D%3D" tx_settings { serializable_read_write { } } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2026-03-25 17:14:46,555 - DEBUG - ydb.connection.2480905  - _log_response: RpcState(BeginTransaction, 3b9e4883-4d97-47b2-9633-20140e6af941, ghrun-ve2ie6ihly.auto.internal:19531): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.BeginTransactionResult] { tx_meta { id: "01kmjzvpcv0jsn6y7v9gebjwt7" } } } } }
2026-03-25 17:14:46,556 - DEBUG - ydb.connection.2480905  - _prepare_call: RpcState(BeginTransaction, 6823dab9-7f15-4038-ae93-51af14605285, ghrun-ve2ie6ihly.auto.internal:19531): creating call state
2026-03-25 17:14:46,556 - DEBUG - ydb.connection.2480905  - _log_request: RpcState(BeginTransaction, 6823dab9-7f15-4038-ae93-51af14605285, ghrun-ve2ie6ihly.auto.internal:19531): request = { session_id: "ydb://session/3?node_id=1&id=MWU5MDU3MjMtOTA0ZGZlYy0zZGQ4Yjg0My1mNjJhNWMxNA%3D%3D" tx_settings { serializable_read_write { } } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2026-03-25 17:14:46,558 - DEBUG - ydb.connection.2480905  - _log_response: RpcState(BeginTransaction, 6823dab9-7f15-4038-ae93-51af14605285, ghrun-ve2ie6ihly.auto.internal:19531): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.BeginTransactionResult] { tx_meta { id: "01kmjzvpcx7dhvmnn7hdwmke1j" } } } } }
2026-03-25 17:14:46,559 - DEBUG - ydb.connection.2480905  - _prepare_call: RpcState(BeginTransaction, 05b7e36f-0fe8-4c13-b33e-e09fff4b3c43, ghrun-ve2ie6ihly.auto.internal:19531): creating call state
2026-03-25 17:14:46,559 - DEBUG - ydb.connection.2480905  - _log_request: RpcState(BeginTransaction, 05b7e36f-0fe8-4c13-b33e-e09fff4b3c43, ghrun-ve2ie6ihly.auto.internal:19531): request = { session_id: "ydb://session/3?node_id=1&id=MWU5MDU3MjMtOTA0ZGZlYy0zZGQ4Yjg0My1mNjJhNWMxNA%3D%3D" tx_settings { serializable_read_write { } } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2026-03-25 17:14:46,561 - DEBUG - ydb.connection.2480905  - _log_response: RpcState(BeginTransaction, 05b7e36f-0fe8-4c13-b33e-e09fff4b3c43, ghrun-ve2ie6ihly.auto.internal:19531): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.BeginTransactionResult] { tx_meta { id: "01kmjzvpd09vztfsm4wtqz5qch" } } } } }
2026-03-25 17:14:46,561 - DEBUG - ydb.connection.2480905  - _prepare_call: RpcState(BeginTransaction, 64feec0e-ac02-4c48-aded-dcf473fe1a87, ghrun-ve2ie6ihly.auto.internal:19531): creating call state
2026-03-25 17:14:46,562 - DEBUG - ydb.connection.2480905  - _log_request: RpcState(BeginTransaction, 64feec0e-ac02-4c48-aded-dcf473fe1a87, ghrun-ve2ie6ihly.auto.internal:19531): request = { session_id: "ydb://session/3?node_id=1&id=MWU5MDU3MjMtOTA0ZGZlYy0zZGQ4Yjg0My1mNjJhNWMxNA%3D%3D" tx_settings { serializable_read_write { } } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2026-03-25 17:14:46,564 - DEBUG - ydb.connection.2480905  - _log_response: RpcState(BeginTransaction, 64feec0e-ac02-4c48-aded-dcf473fe1a87, ghrun-ve2ie6ihly.auto.internal:19531): response = { operation { ready: true status: BAD_SESSION issues { message: "Exceeded maximum allowed number of active transactions" issue_code: 2014 severity: 1 } issues { message: "ydb/core/kqp/session_actor/kqp_session_actor.cpp:1131: Too many transactions, current active: 10 MaxTxPerSession: 10" severity: 1 } result { [type.googleapis.com/Ydb.Table.BeginTransactionResult] { tx_meta { id: "01kmjzvpd21bmawp3fe1thndbd" } } } } }
2026-03-25 17:14:46,566 - INFO - ya.test.2480905  - pytest_runtest_teardown: Test teardown
