2025-10-31 13:48:06,777 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-31 13:48:06,792 - INFO - ya.test - pytest_runtest_setup: test_read_skew_g_single_write_predicate
2025-10-31 13:48:06,792 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-31 13:48:06,792 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-31 13:48:06,793 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_isolation.py::TestTransactionIsolation, test_name: test_read_skew_g_single_write_predicate)
2025-10-31 13:48:06,794 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 3a081764-dd81-4bff-95a6-e2a33412b6a5, ghrun-e45ihybpyu.auto.internal:20918): creating call state
2025-10-31 13:48:06,796 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 3a081764-dd81-4bff-95a6-e2a33412b6a5, ghrun-e45ihybpyu.auto.internal:20918): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 13:48:06,799 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 3a081764-dd81-4bff-95a6-e2a33412b6a5, ghrun-e45ihybpyu.auto.internal:20918): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=ZDA0OTFhZC1kMjczNDdiYS03MWE0ZTQ2Ni0xNzZjNzNmZQ==" } } } }
2025-10-31 13:48:06,799 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, 64bf1c36-3b38-478c-8748-843ffbb9653a, ghrun-e45ihybpyu.auto.internal:20918): creating call state
2025-10-31 13:48:06,800 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, 64bf1c36-3b38-478c-8748-843ffbb9653a, ghrun-e45ihybpyu.auto.internal:20918): request = { session_id: "ydb://session/3?node_id=1&id=ZDA0OTFhZC1kMjczNDdiYS03MWE0ZTQ2Ni0xNzZjNzNmZQ==" yql_text: "create table test_read_skew_g_single_write_predicate (id Int32, value Int32, primary key(id)); " operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 13:48:06,896 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, 64bf1c36-3b38-478c-8748-843ffbb9653a, ghrun-e45ihybpyu.auto.internal:20918): response = { operation { ready: true status: SUCCESS } }
2025-10-31 13:48:06,897 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 95382947-e936-4a2b-8f11-049c8b1877de, ghrun-e45ihybpyu.auto.internal:20918): creating call state
2025-10-31 13:48:06,901 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 95382947-e936-4a2b-8f11-049c8b1877de, ghrun-e45ihybpyu.auto.internal:20918): request = { session_id: "ydb://session/3?node_id=1&id=ZDA0OTFhZC1kMjczNDdiYS03MWE0ZTQ2Ni0xNzZjNzNmZQ==" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "upsert into test_read_skew_g_single_write_predicate (id, value) values (1, 10), (2, 20); " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 13:48:06,929 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 95382947-e936-4a2b-8f11-049c8b1877de, ghrun-e45ihybpyu.auto.internal:20918): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-10-31 13:48:06,931 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, b65cb5e7-6d0a-4493-97a4-65b1f96c3192, ghrun-e45ihybpyu.auto.internal:20918): creating call state
2025-10-31 13:48:06,931 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, b65cb5e7-6d0a-4493-97a4-65b1f96c3192, ghrun-e45ihybpyu.auto.internal:20918): request = { session_id: "ydb://session/3?node_id=1&id=ZDA0OTFhZC1kMjczNDdiYS03MWE0ZTQ2Ni0xNzZjNzNmZQ==" tx_control { begin_tx { serializable_read_write { } } } query { yql_text: " select value from test_read_skew_g_single_write_predicate where id = 1;" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 13:48:06,957 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, b65cb5e7-6d0a-4493-97a4-65b1f96c3192, ghrun-e45ihybpyu.auto.internal:20918): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { result_sets { columns { name: "value" type { optional_type { item { type_id: INT32 } } } } rows { items { int32_value: 10 } } format: FORMAT_VALUE } tx_meta { id: "01k8x8d2d8cz8ha8ada3923c4d" } } } } }
2025-10-31 13:48:06,958 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 1c53b94c-3786-4784-96fb-f432a39d2620, ghrun-e45ihybpyu.auto.internal:20918): creating call state
2025-10-31 13:48:06,960 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 1c53b94c-3786-4784-96fb-f432a39d2620, ghrun-e45ihybpyu.auto.internal:20918): request = { session_id: "ydb://session/3?node_id=1&id=ZDA0OTFhZC1kMjczNDdiYS03MWE0ZTQ2Ni0xNzZjNzNmZQ==" tx_control { begin_tx { serializable_read_write { } } } query { yql_text: " select * from test_read_skew_g_single_write_predicate;" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 13:48:06,991 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 1c53b94c-3786-4784-96fb-f432a39d2620, ghrun-e45ihybpyu.auto.internal:20918): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { result_sets { columns { name: "id" type { optional_type { item { type_id: INT32 } } } } columns { name: "value" type { optional_type { item { type_id: INT32 } } } } rows { items { int32_value: 1 } items { int32_value: 10 } } rows { items { int32_value: 2 } items { int32_value: 20 } } format: FORMAT_VALUE } tx_meta { id: "01k8x8d2ebedz1981xxwcmb71q" } } } } }
2025-10-31 13:48:06,992 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 6920b3f1-b2be-430f-8578-94f2efb36839, ghrun-e45ihybpyu.auto.internal:20918): creating call state
2025-10-31 13:48:06,994 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 6920b3f1-b2be-430f-8578-94f2efb36839, ghrun-e45ihybpyu.auto.internal:20918): request = { session_id: "ydb://session/3?node_id=1&id=ZDA0OTFhZC1kMjczNDdiYS03MWE0ZTQ2Ni0xNzZjNzNmZQ==" tx_control { tx_id: "01k8x8d2ebedz1981xxwcmb71q" } query { yql_text: " upsert into test_read_skew_g_single_write_predicate (id, value) values (1, 12)" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 13:48:07,007 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 6920b3f1-b2be-430f-8578-94f2efb36839, ghrun-e45ihybpyu.auto.internal:20918): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { id: "01k8x8d2ebedz1981xxwcmb71q" } } } } }
2025-10-31 13:48:07,008 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 32539080-7ff2-447e-8815-cdaa5cc0b9bd, ghrun-e45ihybpyu.auto.internal:20918): creating call state
2025-10-31 13:48:07,008 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 32539080-7ff2-447e-8815-cdaa5cc0b9bd, ghrun-e45ihybpyu.auto.internal:20918): request = { session_id: "ydb://session/3?node_id=1&id=ZDA0OTFhZC1kMjczNDdiYS03MWE0ZTQ2Ni0xNzZjNzNmZQ==" tx_control { tx_id: "01k8x8d2ebedz1981xxwcmb71q" } query { yql_text: " upsert into test_read_skew_g_single_write_predicate (id, value) values (2, 18);" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 13:48:07,021 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 32539080-7ff2-447e-8815-cdaa5cc0b9bd, ghrun-e45ihybpyu.auto.internal:20918): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { id: "01k8x8d2ebedz1981xxwcmb71q" } } } } }
2025-10-31 13:48:07,022 - DEBUG - ydb.connection - _prepare_call: RpcState(CommitTransaction, 8e64be54-7ef8-4bf8-87ff-854cc4875375, ghrun-e45ihybpyu.auto.internal:20918): creating call state
2025-10-31 13:48:07,024 - DEBUG - ydb.connection - _log_request: RpcState(CommitTransaction, 8e64be54-7ef8-4bf8-87ff-854cc4875375, ghrun-e45ihybpyu.auto.internal:20918): request = { session_id: "ydb://session/3?node_id=1&id=ZDA0OTFhZC1kMjczNDdiYS03MWE0ZTQ2Ni0xNzZjNzNmZQ==" tx_id: "01k8x8d2ebedz1981xxwcmb71q" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 13:48:07,029 - DEBUG - ydb.connection - _log_response: RpcState(CommitTransaction, 8e64be54-7ef8-4bf8-87ff-854cc4875375, ghrun-e45ihybpyu.auto.internal:20918): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CommitTransactionResult] { } } } }
2025-10-31 13:48:07,030 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 225483a8-20b4-45b7-ad8a-102c5b19d951, ghrun-e45ihybpyu.auto.internal:20918): creating call state
2025-10-31 13:48:07,030 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 225483a8-20b4-45b7-ad8a-102c5b19d951, ghrun-e45ihybpyu.auto.internal:20918): request = { session_id: "ydb://session/3?node_id=1&id=ZDA0OTFhZC1kMjczNDdiYS03MWE0ZTQ2Ni0xNzZjNzNmZQ==" tx_control { tx_id: "01k8x8d2d8cz8ha8ada3923c4d" commit_tx: true } query { yql_text: " delete from test_read_skew_g_single_write_predicate where value = 20;" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 13:48:07,085 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 225483a8-20b4-45b7-ad8a-102c5b19d951, ghrun-e45ihybpyu.auto.internal:20918): response = { operation { ready: true status: ABORTED issues { message: "Transaction locks invalidated. Table: `/Root/test_read_skew_g_single_write_predicate`" issue_code: 2001 severity: 1 } result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { id: "01k8x8d2d8cz8ha8ada3923c4d" } } } } }
2025-10-31 13:48:07,124 - INFO - ya.test - pytest_runtest_teardown: Test teardown
