2025-12-08 23:27:59,862 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-12-08 23:27:59,862 - INFO - ya.test - pytest_runtest_setup: test_anti_dependency_cycles_g2
2025-12-08 23:27:59,863 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-12-08 23:27:59,863 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-12-08 23:27:59,874 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_isolation.py::TestTransactionIsolation, test_name: test_anti_dependency_cycles_g2)
2025-12-08 23:27:59,874 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, efe286a9-83d4-44d2-ac35-3f5c90416c11, ghrun-sfoiezpm3a.auto.internal:1948): creating call state
2025-12-08 23:27:59,923 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, efe286a9-83d4-44d2-ac35-3f5c90416c11, ghrun-sfoiezpm3a.auto.internal:1948): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-12-08 23:27:59,953 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, efe286a9-83d4-44d2-ac35-3f5c90416c11, ghrun-sfoiezpm3a.auto.internal:1948): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=YWI2ZDY2ZC1jYWM4YThhNy1iM2E1OWI2My1jZDJjOWIxOA==" } } } }
2025-12-08 23:27:59,954 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, 02c648e9-c97e-4f15-8b54-11db9b84c280, ghrun-sfoiezpm3a.auto.internal:1948): creating call state
2025-12-08 23:27:59,959 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, 02c648e9-c97e-4f15-8b54-11db9b84c280, ghrun-sfoiezpm3a.auto.internal:1948): request = { session_id: "ydb://session/3?node_id=1&id=YWI2ZDY2ZC1jYWM4YThhNy1iM2E1OWI2My1jZDJjOWIxOA==" yql_text: "create table test_anti_dependency_cycles_g2 (id Int32, value Int32, primary key(id)); " operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-12-08 23:28:00,038 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, 02c648e9-c97e-4f15-8b54-11db9b84c280, ghrun-sfoiezpm3a.auto.internal:1948): response = { operation { ready: true status: SUCCESS } }
2025-12-08 23:28:00,038 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, d31d07d8-3788-4536-9b1a-c8c1d3c2f4a5, ghrun-sfoiezpm3a.auto.internal:1948): creating call state
2025-12-08 23:28:00,054 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, d31d07d8-3788-4536-9b1a-c8c1d3c2f4a5, ghrun-sfoiezpm3a.auto.internal:1948): request = { session_id: "ydb://session/3?node_id=1&id=YWI2ZDY2ZC1jYWM4YThhNy1iM2E1OWI2My1jZDJjOWIxOA==" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "upsert into test_anti_dependency_cycles_g2 (id, value) values (1, 10), (2, 20); " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-12-08 23:28:00,088 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, d31d07d8-3788-4536-9b1a-c8c1d3c2f4a5, ghrun-sfoiezpm3a.auto.internal:1948): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-12-08 23:28:00,089 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 1c0900aa-2010-447d-bf8c-89a93c14f337, ghrun-sfoiezpm3a.auto.internal:1948): creating call state
2025-12-08 23:28:00,110 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 1c0900aa-2010-447d-bf8c-89a93c14f337, ghrun-sfoiezpm3a.auto.internal:1948): request = { session_id: "ydb://session/3?node_id=1&id=YWI2ZDY2ZC1jYWM4YThhNy1iM2E1OWI2My1jZDJjOWIxOA==" tx_control { begin_tx { serializable_read_write { } } } query { yql_text: " select value from test_anti_dependency_cycles_g2 where value % 3 = 0;" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-12-08 23:28:00,182 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 1c0900aa-2010-447d-bf8c-89a93c14f337, ghrun-sfoiezpm3a.auto.internal:1948): 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 } } } } format: FORMAT_VALUE } tx_meta { id: "01kc04p65g9t2t49xwqbjqm478" } } } } }
2025-12-08 23:28:00,186 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, d42cc56e-affd-45a5-b46c-556e169ab0d9, ghrun-sfoiezpm3a.auto.internal:1948): creating call state
2025-12-08 23:28:00,187 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, d42cc56e-affd-45a5-b46c-556e169ab0d9, ghrun-sfoiezpm3a.auto.internal:1948): request = { session_id: "ydb://session/3?node_id=1&id=YWI2ZDY2ZC1jYWM4YThhNy1iM2E1OWI2My1jZDJjOWIxOA==" tx_control { begin_tx { serializable_read_write { } } } query { yql_text: " select value from test_anti_dependency_cycles_g2 where value % 3 = 0;" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-12-08 23:28:00,235 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, d42cc56e-affd-45a5-b46c-556e169ab0d9, ghrun-sfoiezpm3a.auto.internal:1948): 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 } } } } format: FORMAT_VALUE } tx_meta { id: "01kc04p6750615chvs90pvbwpw" } } } } }
2025-12-08 23:28:00,236 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 34f291a1-facc-4729-accd-7423f9e10899, ghrun-sfoiezpm3a.auto.internal:1948): creating call state
2025-12-08 23:28:00,242 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 34f291a1-facc-4729-accd-7423f9e10899, ghrun-sfoiezpm3a.auto.internal:1948): request = { session_id: "ydb://session/3?node_id=1&id=YWI2ZDY2ZC1jYWM4YThhNy1iM2E1OWI2My1jZDJjOWIxOA==" tx_control { tx_id: "01kc04p65g9t2t49xwqbjqm478" } query { yql_text: " upsert into test_anti_dependency_cycles_g2 (id, value) values(3, 30);" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-12-08 23:28:00,263 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 34f291a1-facc-4729-accd-7423f9e10899, ghrun-sfoiezpm3a.auto.internal:1948): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { id: "01kc04p65g9t2t49xwqbjqm478" } } } } }
2025-12-08 23:28:00,264 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 68b3ada1-6811-4493-bbc2-f25ad45c33b4, ghrun-sfoiezpm3a.auto.internal:1948): creating call state
2025-12-08 23:28:00,265 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 68b3ada1-6811-4493-bbc2-f25ad45c33b4, ghrun-sfoiezpm3a.auto.internal:1948): request = { session_id: "ydb://session/3?node_id=1&id=YWI2ZDY2ZC1jYWM4YThhNy1iM2E1OWI2My1jZDJjOWIxOA==" tx_control { tx_id: "01kc04p6750615chvs90pvbwpw" } query { yql_text: " upsert into test_anti_dependency_cycles_g2 (id, value) values(4, 42);" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-12-08 23:28:00,286 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 68b3ada1-6811-4493-bbc2-f25ad45c33b4, ghrun-sfoiezpm3a.auto.internal:1948): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { id: "01kc04p6750615chvs90pvbwpw" } } } } }
2025-12-08 23:28:00,287 - DEBUG - ydb.connection - _prepare_call: RpcState(CommitTransaction, e637fa3b-5a3f-41d5-a5e2-1a5a0c4d955b, ghrun-sfoiezpm3a.auto.internal:1948): creating call state
2025-12-08 23:28:00,304 - DEBUG - ydb.connection - _log_request: RpcState(CommitTransaction, e637fa3b-5a3f-41d5-a5e2-1a5a0c4d955b, ghrun-sfoiezpm3a.auto.internal:1948): request = { session_id: "ydb://session/3?node_id=1&id=YWI2ZDY2ZC1jYWM4YThhNy1iM2E1OWI2My1jZDJjOWIxOA==" tx_id: "01kc04p65g9t2t49xwqbjqm478" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-12-08 23:28:00,311 - DEBUG - ydb.connection - _log_response: RpcState(CommitTransaction, e637fa3b-5a3f-41d5-a5e2-1a5a0c4d955b, ghrun-sfoiezpm3a.auto.internal:1948): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CommitTransactionResult] { } } } }
2025-12-08 23:28:00,316 - DEBUG - ydb.connection - _prepare_call: RpcState(CommitTransaction, 1cd7b089-8487-4cd7-98c2-5928b7083307, ghrun-sfoiezpm3a.auto.internal:1948): creating call state
2025-12-08 23:28:00,317 - DEBUG - ydb.connection - _log_request: RpcState(CommitTransaction, 1cd7b089-8487-4cd7-98c2-5928b7083307, ghrun-sfoiezpm3a.auto.internal:1948): request = { session_id: "ydb://session/3?node_id=1&id=YWI2ZDY2ZC1jYWM4YThhNy1iM2E1OWI2My1jZDJjOWIxOA==" tx_id: "01kc04p6750615chvs90pvbwpw" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-12-08 23:28:00,322 - DEBUG - ydb.connection - _log_response: RpcState(CommitTransaction, 1cd7b089-8487-4cd7-98c2-5928b7083307, ghrun-sfoiezpm3a.auto.internal:1948): response = { operation { ready: true status: ABORTED issues { message: "Transaction locks invalidated. Table: `/Root/test_anti_dependency_cycles_g2`" issue_code: 2001 severity: 1 } } }
2025-12-08 23:28:00,338 - INFO - ya.test - pytest_runtest_teardown: Test teardown
