2025-10-31 13:48:07,604 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-31 13:48:07,604 - INFO - ya.test - pytest_runtest_setup: test_anti_dependency_cycles_g2
2025-10-31 13:48:07,604 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-31 13:48:07,604 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-31 13:48:07,607 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_isolation.py::TestTransactionIsolation, test_name: test_anti_dependency_cycles_g2)
2025-10-31 13:48:07,608 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 1bbf4616-6745-45a1-9def-7a02db72ae3a, ghrun-e45ihybpyu.auto.internal:20918): creating call state
2025-10-31 13:48:07,608 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 1bbf4616-6745-45a1-9def-7a02db72ae3a, ghrun-e45ihybpyu.auto.internal:20918): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 13:48:07,611 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 1bbf4616-6745-45a1-9def-7a02db72ae3a, 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=ZDIyMmY0NTAtYzJmNGVjZDYtMjIyM2E4YzctZGY4MTYzZTc=" } } } }
2025-10-31 13:48:07,612 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, 416f68c3-3629-4760-b273-d34132e2e895, ghrun-e45ihybpyu.auto.internal:20918): creating call state
2025-10-31 13:48:07,612 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, 416f68c3-3629-4760-b273-d34132e2e895, ghrun-e45ihybpyu.auto.internal:20918): request = { session_id: "ydb://session/3?node_id=1&id=ZDIyMmY0NTAtYzJmNGVjZDYtMjIyM2E4YzctZGY4MTYzZTc=" 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-10-31 13:48:07,690 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, 416f68c3-3629-4760-b273-d34132e2e895, ghrun-e45ihybpyu.auto.internal:20918): response = { operation { ready: true status: SUCCESS } }
2025-10-31 13:48:07,692 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, cb3b53e5-71ad-4bc4-8186-84f7ea3b67c3, ghrun-e45ihybpyu.auto.internal:20918): creating call state
2025-10-31 13:48:07,692 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, cb3b53e5-71ad-4bc4-8186-84f7ea3b67c3, ghrun-e45ihybpyu.auto.internal:20918): request = { session_id: "ydb://session/3?node_id=1&id=ZDIyMmY0NTAtYzJmNGVjZDYtMjIyM2E4YzctZGY4MTYzZTc=" 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-10-31 13:48:07,710 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, cb3b53e5-71ad-4bc4-8186-84f7ea3b67c3, 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:07,717 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, db3aebdd-f1fb-4f12-863c-81bc68746da7, ghrun-e45ihybpyu.auto.internal:20918): creating call state
2025-10-31 13:48:07,719 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, db3aebdd-f1fb-4f12-863c-81bc68746da7, ghrun-e45ihybpyu.auto.internal:20918): request = { session_id: "ydb://session/3?node_id=1&id=ZDIyMmY0NTAtYzJmNGVjZDYtMjIyM2E4YzctZGY4MTYzZTc=" 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-10-31 13:48:07,771 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, db3aebdd-f1fb-4f12-863c-81bc68746da7, 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 } } } } format: FORMAT_VALUE } tx_meta { id: "01k8x8d36s3pamjwpa2xdsac70" } } } } }
2025-10-31 13:48:07,772 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, cee72ae3-1371-4cd7-9f6d-d7080dd2eb6c, ghrun-e45ihybpyu.auto.internal:20918): creating call state
2025-10-31 13:48:07,800 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, cee72ae3-1371-4cd7-9f6d-d7080dd2eb6c, ghrun-e45ihybpyu.auto.internal:20918): request = { session_id: "ydb://session/3?node_id=1&id=ZDIyMmY0NTAtYzJmNGVjZDYtMjIyM2E4YzctZGY4MTYzZTc=" 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-10-31 13:48:07,830 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, cee72ae3-1371-4cd7-9f6d-d7080dd2eb6c, 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 } } } } format: FORMAT_VALUE } tx_meta { id: "01k8x8d38m2tn0vbzybw2h5ams" } } } } }
2025-10-31 13:48:07,831 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, fb3bf56f-3c42-45b1-b084-64ae267b74f3, ghrun-e45ihybpyu.auto.internal:20918): creating call state
2025-10-31 13:48:07,832 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, fb3bf56f-3c42-45b1-b084-64ae267b74f3, ghrun-e45ihybpyu.auto.internal:20918): request = { session_id: "ydb://session/3?node_id=1&id=ZDIyMmY0NTAtYzJmNGVjZDYtMjIyM2E4YzctZGY4MTYzZTc=" tx_control { tx_id: "01k8x8d36s3pamjwpa2xdsac70" } 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-10-31 13:48:07,849 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, fb3bf56f-3c42-45b1-b084-64ae267b74f3, ghrun-e45ihybpyu.auto.internal:20918): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { id: "01k8x8d36s3pamjwpa2xdsac70" } } } } }
2025-10-31 13:48:07,850 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, a5d21332-b334-4e18-8620-b15e05e5b695, ghrun-e45ihybpyu.auto.internal:20918): creating call state
2025-10-31 13:48:07,850 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, a5d21332-b334-4e18-8620-b15e05e5b695, ghrun-e45ihybpyu.auto.internal:20918): request = { session_id: "ydb://session/3?node_id=1&id=ZDIyMmY0NTAtYzJmNGVjZDYtMjIyM2E4YzctZGY4MTYzZTc=" tx_control { tx_id: "01k8x8d38m2tn0vbzybw2h5ams" } 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-10-31 13:48:07,870 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, a5d21332-b334-4e18-8620-b15e05e5b695, ghrun-e45ihybpyu.auto.internal:20918): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { id: "01k8x8d38m2tn0vbzybw2h5ams" } } } } }
2025-10-31 13:48:07,873 - DEBUG - ydb.connection - _prepare_call: RpcState(CommitTransaction, 173a9af5-8806-465d-93f6-d6c0295288f7, ghrun-e45ihybpyu.auto.internal:20918): creating call state
2025-10-31 13:48:07,873 - DEBUG - ydb.connection - _log_request: RpcState(CommitTransaction, 173a9af5-8806-465d-93f6-d6c0295288f7, ghrun-e45ihybpyu.auto.internal:20918): request = { session_id: "ydb://session/3?node_id=1&id=ZDIyMmY0NTAtYzJmNGVjZDYtMjIyM2E4YzctZGY4MTYzZTc=" tx_id: "01k8x8d36s3pamjwpa2xdsac70" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 13:48:07,889 - DEBUG - ydb.connection - _log_response: RpcState(CommitTransaction, 173a9af5-8806-465d-93f6-d6c0295288f7, ghrun-e45ihybpyu.auto.internal:20918): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CommitTransactionResult] { } } } }
2025-10-31 13:48:07,890 - DEBUG - ydb.connection - _prepare_call: RpcState(CommitTransaction, 2d253380-1267-4fa2-8b1c-1aad618fe92e, ghrun-e45ihybpyu.auto.internal:20918): creating call state
2025-10-31 13:48:07,890 - DEBUG - ydb.connection - _log_request: RpcState(CommitTransaction, 2d253380-1267-4fa2-8b1c-1aad618fe92e, ghrun-e45ihybpyu.auto.internal:20918): request = { session_id: "ydb://session/3?node_id=1&id=ZDIyMmY0NTAtYzJmNGVjZDYtMjIyM2E4YzctZGY4MTYzZTc=" tx_id: "01k8x8d38m2tn0vbzybw2h5ams" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 13:48:07,895 - DEBUG - ydb.connection - _log_response: RpcState(CommitTransaction, 2d253380-1267-4fa2-8b1c-1aad618fe92e, ghrun-e45ihybpyu.auto.internal:20918): response = { operation { ready: true status: ABORTED issues { message: "Transaction locks invalidated. Table: `/Root/test_anti_dependency_cycles_g2`." issue_code: 2001 severity: 1 issues { message: "Operation is aborting because locks are not valid" issue_code: 2001 severity: 1 } } } }
2025-10-31 13:48:07,905 - INFO - ya.test - pytest_runtest_teardown: Test teardown
