2025-11-26 18:42:15,621 - INFO - ya.test.2335202  - pytest_runtest_setup: ####################################################################################################
2025-11-26 18:42:15,621 - INFO - ya.test.2335202  - pytest_runtest_setup: test_locks_invalidated_error
2025-11-26 18:42:15,621 - INFO - ya.test.2335202  - pytest_runtest_setup: ####################################################################################################
2025-11-26 18:42:15,622 - INFO - ya.test.2335202  - pytest_runtest_setup: Test setup
2025-11-26 18:42:15,622 - INFO - ya.test.2335202  - pytest_runtest_call: Test call (class_name: test_public_api.py::TestCRUDOperations, test_name: test_locks_invalidated_error)
2025-11-26 18:42:15,623 - DEBUG - ydb.connection.2335202  - _prepare_call: RpcState(CreateSession, 30f21405-6ccf-43e5-9466-aa55bd06a429, ghrun-ihttfokzrq.auto.internal:11726): creating call state
2025-11-26 18:42:15,623 - DEBUG - ydb.connection.2335202  - _log_request: RpcState(CreateSession, 30f21405-6ccf-43e5-9466-aa55bd06a429, ghrun-ihttfokzrq.auto.internal:11726): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 18:42:15,626 - DEBUG - ydb.connection.2335202  - _log_response: RpcState(CreateSession, 30f21405-6ccf-43e5-9466-aa55bd06a429, ghrun-ihttfokzrq.auto.internal:11726): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=YTM5ZDgxMWItZjdmYWExNzMtOTc4NTY2ZjQtNDUyMjczYjc=" } } } }
2025-11-26 18:42:15,627 - DEBUG - ydb.connection.2335202  - _prepare_call: RpcState(CreateSession, 0d1cf0f6-9c42-42cf-a5db-38b16291abb9, ghrun-ihttfokzrq.auto.internal:11726): creating call state
2025-11-26 18:42:15,627 - DEBUG - ydb.connection.2335202  - _log_request: RpcState(CreateSession, 0d1cf0f6-9c42-42cf-a5db-38b16291abb9, ghrun-ihttfokzrq.auto.internal:11726): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 18:42:15,629 - DEBUG - ydb.connection.2335202  - _log_response: RpcState(CreateSession, 0d1cf0f6-9c42-42cf-a5db-38b16291abb9, ghrun-ihttfokzrq.auto.internal:11726): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=ZmJhZWE1MzAtNmU4NWIyOC1lM2FmZmU0Mi1jMWJjMGI3Mw==" } } } }
2025-11-26 18:42:15,630 - DEBUG - ydb.connection.2335202  - _prepare_call: RpcState(ExecuteSchemeQuery, d08a7e04-28a5-455a-b3ae-7d537941ac09, ghrun-ihttfokzrq.auto.internal:11726): creating call state
2025-11-26 18:42:15,630 - DEBUG - ydb.connection.2335202  - _log_request: RpcState(ExecuteSchemeQuery, d08a7e04-28a5-455a-b3ae-7d537941ac09, ghrun-ihttfokzrq.auto.internal:11726): request = { session_id: "ydb://session/3?node_id=1&id=YTM5ZDgxMWItZjdmYWExNzMtOTc4NTY2ZjQtNDUyMjczYjc=" yql_text: "create table kv_table (key Int32, value Utf8, primary key(key));" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 18:42:15,658 - DEBUG - ydb.connection.2335202  - _log_response: RpcState(ExecuteSchemeQuery, d08a7e04-28a5-455a-b3ae-7d537941ac09, ghrun-ihttfokzrq.auto.internal:11726): response = { operation { ready: true status: SUCCESS } }
2025-11-26 18:42:15,659 - DEBUG - ydb.connection.2335202  - _prepare_call: RpcState(ExecuteDataQuery, 35a10334-b9e1-4cc9-9a9b-eb9be0dcb9e1, ghrun-ihttfokzrq.auto.internal:11726): creating call state
2025-11-26 18:42:15,659 - DEBUG - ydb.connection.2335202  - _log_request: RpcState(ExecuteDataQuery, 35a10334-b9e1-4cc9-9a9b-eb9be0dcb9e1, ghrun-ihttfokzrq.auto.internal:11726): request = { session_id: "ydb://session/3?node_id=1&id=ZmJhZWE1MzAtNmU4NWIyOC1lM2FmZmU0Mi1jMWJjMGI3Mw==" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "upsert into kv_table (key, value) VALUES (1, \"4\");" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 18:42:15,678 - DEBUG - ydb.connection.2335202  - _log_response: RpcState(ExecuteDataQuery, 35a10334-b9e1-4cc9-9a9b-eb9be0dcb9e1, ghrun-ihttfokzrq.auto.internal:11726): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-26 18:42:15,679 - DEBUG - ydb.connection.2335202  - _prepare_call: RpcState(ExecuteDataQuery, 478c2420-9899-49a9-ab89-86351f9bec6f, ghrun-ihttfokzrq.auto.internal:11726): creating call state
2025-11-26 18:42:15,680 - DEBUG - ydb.connection.2335202  - _log_request: RpcState(ExecuteDataQuery, 478c2420-9899-49a9-ab89-86351f9bec6f, ghrun-ihttfokzrq.auto.internal:11726): request = { session_id: "ydb://session/3?node_id=1&id=YTM5ZDgxMWItZjdmYWExNzMtOTc4NTY2ZjQtNDUyMjczYjc=" tx_control { begin_tx { serializable_read_write { } } } query { yql_text: "select value from kv_table where key=1;" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 18:42:15,703 - DEBUG - ydb.connection.2335202  - _log_response: RpcState(ExecuteDataQuery, 478c2420-9899-49a9-ab89-86351f9bec6f, ghrun-ihttfokzrq.auto.internal:11726): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { result_sets { columns { name: "value" type { optional_type { item { type_id: UTF8 } } } } rows { items { text_value: "4" } } format: FORMAT_VALUE } tx_meta { id: "01kb0qjbgk6cg2nvx22wba89cn" } } } } }
2025-11-26 18:42:15,704 - DEBUG - ydb.connection.2335202  - _prepare_call: RpcState(ExecuteDataQuery, 29ed7939-9721-46ef-b5c0-8a6de9bc959c, ghrun-ihttfokzrq.auto.internal:11726): creating call state
2025-11-26 18:42:15,705 - DEBUG - ydb.connection.2335202  - _log_request: RpcState(ExecuteDataQuery, 29ed7939-9721-46ef-b5c0-8a6de9bc959c, ghrun-ihttfokzrq.auto.internal:11726): request = { session_id: "ydb://session/3?node_id=1&id=ZmJhZWE1MzAtNmU4NWIyOC1lM2FmZmU0Mi1jMWJjMGI3Mw==" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "upsert into kv_table (key, value) VALUES (1, \"5\");" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 18:42:15,722 - DEBUG - ydb.connection.2335202  - _log_response: RpcState(ExecuteDataQuery, 29ed7939-9721-46ef-b5c0-8a6de9bc959c, ghrun-ihttfokzrq.auto.internal:11726): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-26 18:42:15,722 - DEBUG - ydb.connection.2335202  - _prepare_call: RpcState(ExecuteDataQuery, c131d0c9-c3fc-4301-9285-81679e6a1d71, ghrun-ihttfokzrq.auto.internal:11726): creating call state
2025-11-26 18:42:15,723 - DEBUG - ydb.connection.2335202  - _log_request: RpcState(ExecuteDataQuery, c131d0c9-c3fc-4301-9285-81679e6a1d71, ghrun-ihttfokzrq.auto.internal:11726): request = { session_id: "ydb://session/3?node_id=1&id=YTM5ZDgxMWItZjdmYWExNzMtOTc4NTY2ZjQtNDUyMjczYjc=" tx_control { tx_id: "01kb0qjbgk6cg2nvx22wba89cn" commit_tx: true } query { yql_text: "upsert into kv_table (key, value) VALUES (2, \"3\");" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 18:42:15,737 - DEBUG - ydb.connection.2335202  - _log_response: RpcState(ExecuteDataQuery, c131d0c9-c3fc-4301-9285-81679e6a1d71, ghrun-ihttfokzrq.auto.internal:11726): response = { operation { ready: true status: ABORTED issues { message: "Transaction locks invalidated. Table: `/Root/kv_table`." issue_code: 2001 severity: 1 issues { message: "Operation is aborting because locks are not valid" issue_code: 2001 severity: 1 } } result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { id: "01kb0qjbgk6cg2nvx22wba89cn" } } } } }
2025-11-26 18:42:15,740 - INFO - ya.test.2335202  - pytest_runtest_teardown: Test teardown
