2026-03-25 17:14:53,316 - INFO - ya.test.2499227  - pytest_runtest_setup: ####################################################################################################
2026-03-25 17:14:53,317 - INFO - ya.test.2499227  - pytest_runtest_setup: test_prevents_circular_information_flow_g1c
2026-03-25 17:14:53,317 - INFO - ya.test.2499227  - pytest_runtest_setup: ####################################################################################################
2026-03-25 17:14:53,317 - INFO - ya.test.2499227  - pytest_runtest_setup: Test setup
2026-03-25 17:14:53,318 - INFO - ya.test.2499227  - pytest_runtest_call: Test call (class_name: test_isolation.py::TestTransactionIsolation, test_name: test_prevents_circular_information_flow_g1c)
2026-03-25 17:14:53,318 - DEBUG - ydb.connection.2499227  - _prepare_call: RpcState(CreateSession, 376787b8-54b0-4e5d-9c45-d7f5b6ed5595, ghrun-ve2ie6ihly.auto.internal:65362): creating call state
2026-03-25 17:14:53,318 - DEBUG - ydb.connection.2499227  - _log_request: RpcState(CreateSession, 376787b8-54b0-4e5d-9c45-d7f5b6ed5595, ghrun-ve2ie6ihly.auto.internal:65362): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2026-03-25 17:14:53,320 - DEBUG - ydb.connection.2499227  - _log_response: RpcState(CreateSession, 376787b8-54b0-4e5d-9c45-d7f5b6ed5595, ghrun-ve2ie6ihly.auto.internal:65362): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=ZjY3OWRjZGUtMjE2N2I5MzctZjBiNTJhZTMtZGQ2Nzc2MjE%3D" } } } }
2026-03-25 17:14:53,321 - DEBUG - ydb.connection.2499227  - _prepare_call: RpcState(ExecuteSchemeQuery, 409ef90f-e7d2-4a29-9128-023204fad63d, ghrun-ve2ie6ihly.auto.internal:65362): creating call state
2026-03-25 17:14:53,321 - DEBUG - ydb.connection.2499227  - _log_request: RpcState(ExecuteSchemeQuery, 409ef90f-e7d2-4a29-9128-023204fad63d, ghrun-ve2ie6ihly.auto.internal:65362): request = { session_id: "ydb://session/3?node_id=1&id=ZjY3OWRjZGUtMjE2N2I5MzctZjBiNTJhZTMtZGQ2Nzc2MjE%3D" yql_text: "create table test_prevents_circular_information_flow_g1c (id Int32, value Int32, primary key(id)); " operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2026-03-25 17:14:53,337 - DEBUG - ydb.connection.2499227  - _log_response: RpcState(ExecuteSchemeQuery, 409ef90f-e7d2-4a29-9128-023204fad63d, ghrun-ve2ie6ihly.auto.internal:65362): response = { operation { ready: true status: SUCCESS } }
2026-03-25 17:14:53,337 - DEBUG - ydb.connection.2499227  - _prepare_call: RpcState(ExecuteDataQuery, 898a8e1a-060a-4e7d-a56a-058c26bf3f11, ghrun-ve2ie6ihly.auto.internal:65362): creating call state
2026-03-25 17:14:53,338 - DEBUG - ydb.connection.2499227  - _log_request: RpcState(ExecuteDataQuery, 898a8e1a-060a-4e7d-a56a-058c26bf3f11, ghrun-ve2ie6ihly.auto.internal:65362): request = { session_id: "ydb://session/3?node_id=1&id=ZjY3OWRjZGUtMjE2N2I5MzctZjBiNTJhZTMtZGQ2Nzc2MjE%3D" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "upsert into test_prevents_circular_information_flow_g1c (id, value) values (1, 10), (2, 20); " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2026-03-25 17:14:53,349 - DEBUG - ydb.connection.2499227  - _log_response: RpcState(ExecuteDataQuery, 898a8e1a-060a-4e7d-a56a-058c26bf3f11, ghrun-ve2ie6ihly.auto.internal:65362): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2026-03-25 17:14:53,350 - DEBUG - ydb.connection.2499227  - _prepare_call: RpcState(ExecuteDataQuery, ed7bf05c-7e41-40da-aa5b-b12d8b31564a, ghrun-ve2ie6ihly.auto.internal:65362): creating call state
2026-03-25 17:14:53,351 - DEBUG - ydb.connection.2499227  - _log_request: RpcState(ExecuteDataQuery, ed7bf05c-7e41-40da-aa5b-b12d8b31564a, ghrun-ve2ie6ihly.auto.internal:65362): request = { session_id: "ydb://session/3?node_id=1&id=ZjY3OWRjZGUtMjE2N2I5MzctZjBiNTJhZTMtZGQ2Nzc2MjE%3D" tx_control { begin_tx { serializable_read_write { } } } query { yql_text: "update test_prevents_circular_information_flow_g1c set value = 11 where id = 1;" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2026-03-25 17:14:53,368 - DEBUG - ydb.connection.2499227  - _log_response: RpcState(ExecuteDataQuery, ed7bf05c-7e41-40da-aa5b-b12d8b31564a, ghrun-ve2ie6ihly.auto.internal:65362): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { id: "01kmjzvx1p7x3hp1pgytcj2jza" } } } } }
2026-03-25 17:14:53,369 - DEBUG - ydb.connection.2499227  - _prepare_call: RpcState(ExecuteDataQuery, 64a99f13-f518-496c-bae7-129b7c5bb6cd, ghrun-ve2ie6ihly.auto.internal:65362): creating call state
2026-03-25 17:14:53,369 - DEBUG - ydb.connection.2499227  - _log_request: RpcState(ExecuteDataQuery, 64a99f13-f518-496c-bae7-129b7c5bb6cd, ghrun-ve2ie6ihly.auto.internal:65362): request = { session_id: "ydb://session/3?node_id=1&id=ZjY3OWRjZGUtMjE2N2I5MzctZjBiNTJhZTMtZGQ2Nzc2MjE%3D" tx_control { begin_tx { serializable_read_write { } } } query { yql_text: "update test_prevents_circular_information_flow_g1c set value = 22 where id = 2;" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2026-03-25 17:14:53,386 - DEBUG - ydb.connection.2499227  - _log_response: RpcState(ExecuteDataQuery, 64a99f13-f518-496c-bae7-129b7c5bb6cd, ghrun-ve2ie6ihly.auto.internal:65362): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { id: "01kmjzvx281x3zcre8dw22yn0e" } } } } }
2026-03-25 17:14:53,387 - DEBUG - ydb.connection.2499227  - _prepare_call: RpcState(ExecuteDataQuery, 285fa0b7-53f1-44ac-9270-afdc511aa558, ghrun-ve2ie6ihly.auto.internal:65362): creating call state
2026-03-25 17:14:53,387 - DEBUG - ydb.connection.2499227  - _log_request: RpcState(ExecuteDataQuery, 285fa0b7-53f1-44ac-9270-afdc511aa558, ghrun-ve2ie6ihly.auto.internal:65362): request = { session_id: "ydb://session/3?node_id=1&id=ZjY3OWRjZGUtMjE2N2I5MzctZjBiNTJhZTMtZGQ2Nzc2MjE%3D" tx_control { tx_id: "01kmjzvx1p7x3hp1pgytcj2jza" } query { yql_text: "select * from test_prevents_circular_information_flow_g1c where id = 2;" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2026-03-25 17:14:53,402 - DEBUG - ydb.connection.2499227  - _log_response: RpcState(ExecuteDataQuery, 285fa0b7-53f1-44ac-9270-afdc511aa558, ghrun-ve2ie6ihly.auto.internal:65362): 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: 2 } items { int32_value: 20 } } format: FORMAT_VALUE } tx_meta { id: "01kmjzvx1p7x3hp1pgytcj2jza" } } } } }
2026-03-25 17:14:53,403 - DEBUG - ydb.connection.2499227  - _prepare_call: RpcState(ExecuteDataQuery, eb6d2fdd-5b04-411c-8bce-ed9285ae7d5f, ghrun-ve2ie6ihly.auto.internal:65362): creating call state
2026-03-25 17:14:53,403 - DEBUG - ydb.connection.2499227  - _log_request: RpcState(ExecuteDataQuery, eb6d2fdd-5b04-411c-8bce-ed9285ae7d5f, ghrun-ve2ie6ihly.auto.internal:65362): request = { session_id: "ydb://session/3?node_id=1&id=ZjY3OWRjZGUtMjE2N2I5MzctZjBiNTJhZTMtZGQ2Nzc2MjE%3D" tx_control { tx_id: "01kmjzvx281x3zcre8dw22yn0e" } query { yql_text: "select * from test_prevents_circular_information_flow_g1c where id = 1;" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2026-03-25 17:14:53,419 - DEBUG - ydb.connection.2499227  - _log_response: RpcState(ExecuteDataQuery, eb6d2fdd-5b04-411c-8bce-ed9285ae7d5f, ghrun-ve2ie6ihly.auto.internal:65362): 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 } } format: FORMAT_VALUE } tx_meta { id: "01kmjzvx281x3zcre8dw22yn0e" } } } } }
2026-03-25 17:14:53,420 - DEBUG - ydb.connection.2499227  - _prepare_call: RpcState(CommitTransaction, 0f2e618e-a340-4f4e-9cfb-861b60745750, ghrun-ve2ie6ihly.auto.internal:65362): creating call state
2026-03-25 17:14:53,420 - DEBUG - ydb.connection.2499227  - _log_request: RpcState(CommitTransaction, 0f2e618e-a340-4f4e-9cfb-861b60745750, ghrun-ve2ie6ihly.auto.internal:65362): request = { session_id: "ydb://session/3?node_id=1&id=ZjY3OWRjZGUtMjE2N2I5MzctZjBiNTJhZTMtZGQ2Nzc2MjE%3D" tx_id: "01kmjzvx1p7x3hp1pgytcj2jza" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2026-03-25 17:14:53,424 - DEBUG - ydb.connection.2499227  - _log_response: RpcState(CommitTransaction, 0f2e618e-a340-4f4e-9cfb-861b60745750, ghrun-ve2ie6ihly.auto.internal:65362): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CommitTransactionResult] { } } } }
2026-03-25 17:14:53,424 - DEBUG - ydb.connection.2499227  - _prepare_call: RpcState(CommitTransaction, 62b9933c-55da-4e9f-a7ec-7bf1b4e8f043, ghrun-ve2ie6ihly.auto.internal:65362): creating call state
2026-03-25 17:14:53,424 - DEBUG - ydb.connection.2499227  - _log_request: RpcState(CommitTransaction, 62b9933c-55da-4e9f-a7ec-7bf1b4e8f043, ghrun-ve2ie6ihly.auto.internal:65362): request = { session_id: "ydb://session/3?node_id=1&id=ZjY3OWRjZGUtMjE2N2I5MzctZjBiNTJhZTMtZGQ2Nzc2MjE%3D" tx_id: "01kmjzvx281x3zcre8dw22yn0e" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2026-03-25 17:14:53,428 - DEBUG - ydb.connection.2499227  - _log_response: RpcState(CommitTransaction, 62b9933c-55da-4e9f-a7ec-7bf1b4e8f043, ghrun-ve2ie6ihly.auto.internal:65362): response = { operation { ready: true status: ABORTED issues { message: "Transaction locks invalidated. Table: `/Root/test_prevents_circular_information_flow_g1c`." issue_code: 2001 severity: 1 } issues { message: "Operation is aborting because locks are not valid" issue_code: 2001 severity: 1 } } }
2026-03-25 17:14:53,430 - INFO - ya.test.2499227  - pytest_runtest_teardown: Test teardown
