2025-12-12 10:05:22,261 - INFO - ya.test.2060683  - pytest_runtest_setup: ####################################################################################################
2025-12-12 10:05:22,261 - INFO - ya.test.2060683  - pytest_runtest_setup: test_anti_dependency_cycles_g2_two_edges
2025-12-12 10:05:22,262 - INFO - ya.test.2060683  - pytest_runtest_setup: ####################################################################################################
2025-12-12 10:05:22,262 - INFO - ya.test.2060683  - pytest_runtest_setup: Test setup
2025-12-12 10:05:22,266 - INFO - ya.test.2060683  - pytest_runtest_call: Test call (class_name: test_isolation.py::TestTransactionIsolation, test_name: test_anti_dependency_cycles_g2_two_edges)
2025-12-12 10:05:22,294 - DEBUG - ydb.connection.2060683  - _prepare_call: RpcState(CreateSession, abb2a433-c3d7-4620-9162-3e9ec0137b25, ghrun-llwi4fnhxu.auto.internal:27863): creating call state
2025-12-12 10:05:22,311 - DEBUG - ydb.connection.2060683  - _log_request: RpcState(CreateSession, abb2a433-c3d7-4620-9162-3e9ec0137b25, ghrun-llwi4fnhxu.auto.internal:27863): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-12-12 10:05:22,315 - DEBUG - ydb.connection.2060683  - _log_response: RpcState(CreateSession, abb2a433-c3d7-4620-9162-3e9ec0137b25, ghrun-llwi4fnhxu.auto.internal:27863): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=Njg5YTYzMGUtYWExNzk2YjgtOTI1MTEyZmEtNTI3NDQ4NDc=" } } } }
2025-12-12 10:05:22,315 - DEBUG - ydb.connection.2060683  - _prepare_call: RpcState(ExecuteSchemeQuery, f0041566-f304-4815-8a1e-e393b70d16f8, ghrun-llwi4fnhxu.auto.internal:27863): creating call state
2025-12-12 10:05:22,317 - DEBUG - ydb.connection.2060683  - _log_request: RpcState(ExecuteSchemeQuery, f0041566-f304-4815-8a1e-e393b70d16f8, ghrun-llwi4fnhxu.auto.internal:27863): request = { session_id: "ydb://session/3?node_id=1&id=Njg5YTYzMGUtYWExNzk2YjgtOTI1MTEyZmEtNTI3NDQ4NDc=" yql_text: "create table test_anti_dependency_cycles_g2_two_edges (id Int32, value Int32, primary key(id)); " operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-12-12 10:05:22,361 - DEBUG - ydb.connection.2060683  - _log_response: RpcState(ExecuteSchemeQuery, f0041566-f304-4815-8a1e-e393b70d16f8, ghrun-llwi4fnhxu.auto.internal:27863): response = { operation { ready: true status: SUCCESS } }
2025-12-12 10:05:22,365 - DEBUG - ydb.connection.2060683  - _prepare_call: RpcState(ExecuteDataQuery, af8159cb-097e-48ec-8f8c-b2e40deb10f3, ghrun-llwi4fnhxu.auto.internal:27863): creating call state
2025-12-12 10:05:22,379 - DEBUG - ydb.connection.2060683  - _log_request: RpcState(ExecuteDataQuery, af8159cb-097e-48ec-8f8c-b2e40deb10f3, ghrun-llwi4fnhxu.auto.internal:27863): request = { session_id: "ydb://session/3?node_id=1&id=Njg5YTYzMGUtYWExNzk2YjgtOTI1MTEyZmEtNTI3NDQ4NDc=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "upsert into test_anti_dependency_cycles_g2_two_edges (id, value) values (1, 10), (2, 20); " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-12-12 10:05:22,422 - DEBUG - ydb.connection.2060683  - _log_response: RpcState(ExecuteDataQuery, af8159cb-097e-48ec-8f8c-b2e40deb10f3, ghrun-llwi4fnhxu.auto.internal:27863): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-12-12 10:05:22,422 - DEBUG - ydb.connection.2060683  - _prepare_call: RpcState(ExecuteDataQuery, d782f778-b090-48bd-99e5-efdc4f4dd14c, ghrun-llwi4fnhxu.auto.internal:27863): creating call state
2025-12-12 10:05:22,424 - DEBUG - ydb.connection.2060683  - _log_request: RpcState(ExecuteDataQuery, d782f778-b090-48bd-99e5-efdc4f4dd14c, ghrun-llwi4fnhxu.auto.internal:27863): request = { session_id: "ydb://session/3?node_id=1&id=Njg5YTYzMGUtYWExNzk2YjgtOTI1MTEyZmEtNTI3NDQ4NDc=" tx_control { begin_tx { serializable_read_write { } } } query { yql_text: " select id, value from test_anti_dependency_cycles_g2_two_edges;" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-12-12 10:05:22,456 - DEBUG - ydb.connection.2060683  - _log_response: RpcState(ExecuteDataQuery, d782f778-b090-48bd-99e5-efdc4f4dd14c, ghrun-llwi4fnhxu.auto.internal:27863): 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: "01kc90bd4k4fwxk81xytkq3c13" } } } } }
2025-12-12 10:05:22,458 - DEBUG - ydb.connection.2060683  - _prepare_call: RpcState(ExecuteDataQuery, 839f98da-8eca-4ab0-968d-ed48f73cdbd7, ghrun-llwi4fnhxu.auto.internal:27863): creating call state
2025-12-12 10:05:22,459 - DEBUG - ydb.connection.2060683  - _log_request: RpcState(ExecuteDataQuery, 839f98da-8eca-4ab0-968d-ed48f73cdbd7, ghrun-llwi4fnhxu.auto.internal:27863): request = { session_id: "ydb://session/3?node_id=1&id=Njg5YTYzMGUtYWExNzk2YjgtOTI1MTEyZmEtNTI3NDQ4NDc=" tx_control { begin_tx { serializable_read_write { } } } query { yql_text: " update test_anti_dependency_cycles_g2_two_edges set value = value + 5 where id = 2;" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-12-12 10:05:22,496 - DEBUG - ydb.connection.2060683  - _log_response: RpcState(ExecuteDataQuery, 839f98da-8eca-4ab0-968d-ed48f73cdbd7, ghrun-llwi4fnhxu.auto.internal:27863): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { id: "01kc90bd5y0r3m4wdj42gbahwr" } } } } }
2025-12-12 10:05:22,497 - DEBUG - ydb.connection.2060683  - _prepare_call: RpcState(CommitTransaction, 79e5ef55-a3bc-41bb-8fa1-60379d8f5b3e, ghrun-llwi4fnhxu.auto.internal:27863): creating call state
2025-12-12 10:05:22,497 - DEBUG - ydb.connection.2060683  - _log_request: RpcState(CommitTransaction, 79e5ef55-a3bc-41bb-8fa1-60379d8f5b3e, ghrun-llwi4fnhxu.auto.internal:27863): request = { session_id: "ydb://session/3?node_id=1&id=Njg5YTYzMGUtYWExNzk2YjgtOTI1MTEyZmEtNTI3NDQ4NDc=" tx_id: "01kc90bd5y0r3m4wdj42gbahwr" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-12-12 10:05:22,504 - DEBUG - ydb.connection.2060683  - _log_response: RpcState(CommitTransaction, 79e5ef55-a3bc-41bb-8fa1-60379d8f5b3e, ghrun-llwi4fnhxu.auto.internal:27863): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CommitTransactionResult] { } } } }
2025-12-12 10:05:22,525 - DEBUG - ydb.connection.2060683  - _prepare_call: RpcState(ExecuteDataQuery, 9e09cd18-9137-466c-bb01-fe69e30bd9b5, ghrun-llwi4fnhxu.auto.internal:27863): creating call state
2025-12-12 10:05:22,526 - DEBUG - ydb.connection.2060683  - _log_request: RpcState(ExecuteDataQuery, 9e09cd18-9137-466c-bb01-fe69e30bd9b5, ghrun-llwi4fnhxu.auto.internal:27863): request = { session_id: "ydb://session/3?node_id=1&id=Njg5YTYzMGUtYWExNzk2YjgtOTI1MTEyZmEtNTI3NDQ4NDc=" tx_control { begin_tx { serializable_read_write { } } } query { yql_text: " select id, value from test_anti_dependency_cycles_g2_two_edges;" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-12-12 10:05:22,576 - DEBUG - ydb.connection.2060683  - _log_response: RpcState(ExecuteDataQuery, 9e09cd18-9137-466c-bb01-fe69e30bd9b5, ghrun-llwi4fnhxu.auto.internal:27863): 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: 25 } } format: FORMAT_VALUE } tx_meta { id: "01kc90bd8b8vjb1redxvgtcw7y" } } } } }
2025-12-12 10:05:22,590 - DEBUG - ydb.connection.2060683  - _prepare_call: RpcState(CommitTransaction, e854ae97-3138-4ee3-8d25-2261c3d11044, ghrun-llwi4fnhxu.auto.internal:27863): creating call state
2025-12-12 10:05:22,592 - DEBUG - ydb.connection.2060683  - _log_request: RpcState(CommitTransaction, e854ae97-3138-4ee3-8d25-2261c3d11044, ghrun-llwi4fnhxu.auto.internal:27863): request = { session_id: "ydb://session/3?node_id=1&id=Njg5YTYzMGUtYWExNzk2YjgtOTI1MTEyZmEtNTI3NDQ4NDc=" tx_id: "01kc90bd8b8vjb1redxvgtcw7y" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-12-12 10:05:22,610 - DEBUG - ydb.connection.2060683  - _log_response: RpcState(CommitTransaction, e854ae97-3138-4ee3-8d25-2261c3d11044, ghrun-llwi4fnhxu.auto.internal:27863): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CommitTransactionResult] { } } } }
2025-12-12 10:05:22,624 - DEBUG - ydb.connection.2060683  - _prepare_call: RpcState(ExecuteDataQuery, 825955ea-753e-4d3a-95ce-70cdae0ba1f6, ghrun-llwi4fnhxu.auto.internal:27863): creating call state
2025-12-12 10:05:22,625 - DEBUG - ydb.connection.2060683  - _log_request: RpcState(ExecuteDataQuery, 825955ea-753e-4d3a-95ce-70cdae0ba1f6, ghrun-llwi4fnhxu.auto.internal:27863): request = { session_id: "ydb://session/3?node_id=1&id=Njg5YTYzMGUtYWExNzk2YjgtOTI1MTEyZmEtNTI3NDQ4NDc=" tx_control { tx_id: "01kc90bd4k4fwxk81xytkq3c13" } query { yql_text: " update test_anti_dependency_cycles_g2_two_edges set value = 0 where id = 1;" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-12-12 10:05:22,652 - DEBUG - ydb.connection.2060683  - _log_response: RpcState(ExecuteDataQuery, 825955ea-753e-4d3a-95ce-70cdae0ba1f6, ghrun-llwi4fnhxu.auto.internal:27863): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { id: "01kc90bd4k4fwxk81xytkq3c13" } } } } }
2025-12-12 10:05:22,653 - DEBUG - ydb.connection.2060683  - _prepare_call: RpcState(CommitTransaction, b2e1c03d-9443-4896-9d48-cf75e5e68607, ghrun-llwi4fnhxu.auto.internal:27863): creating call state
2025-12-12 10:05:22,654 - DEBUG - ydb.connection.2060683  - _log_request: RpcState(CommitTransaction, b2e1c03d-9443-4896-9d48-cf75e5e68607, ghrun-llwi4fnhxu.auto.internal:27863): request = { session_id: "ydb://session/3?node_id=1&id=Njg5YTYzMGUtYWExNzk2YjgtOTI1MTEyZmEtNTI3NDQ4NDc=" tx_id: "01kc90bd4k4fwxk81xytkq3c13" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-12-12 10:05:22,664 - DEBUG - ydb.connection.2060683  - _log_response: RpcState(CommitTransaction, b2e1c03d-9443-4896-9d48-cf75e5e68607, ghrun-llwi4fnhxu.auto.internal:27863): response = { operation { ready: true status: ABORTED issues { message: "Transaction locks invalidated. Table: `/Root/test_anti_dependency_cycles_g2_two_edges`" issue_code: 2001 severity: 1 } } }
2025-12-12 10:05:22,666 - INFO - ya.test.2060683  - pytest_runtest_teardown: Test teardown
2025-12-12 10:05:39,669 - INFO - ydb.tests.library.harness.kikimr_runner.2060683  - stop: Stopped node localhost:27863/1
2025-12-12 10:05:39,671 - DEBUG - library.python.filelock.2060683  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/12703
2025-12-12 10:05:39,674 - DEBUG - library.python.filelock.2060683  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/22100
2025-12-12 10:05:39,675 - DEBUG - library.python.filelock.2060683  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/1100
2025-12-12 10:05:39,676 - DEBUG - library.python.filelock.2060683  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/27863
2025-12-12 10:05:39,677 - DEBUG - library.python.filelock.2060683  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/61896
2025-12-12 10:05:39,677 - DEBUG - ydb.topic.2060683  - close: Close topic client
2025-12-12 10:05:39,678 - DEBUG - ydb.topic.2060683  - close: Topic client was closed
2025-12-12 10:05:39,679 - DEBUG - ydb.connection.2060683  - close: Closing channel for endpoint localhost:27863
2025-12-12 10:05:39,679 - DEBUG - ydb.connection.2060683  - close: Closing channel for endpoint ghrun-llwi4fnhxu.auto.internal:27863
2025-12-12 10:05:39,680 - INFO - ydb.pool.Discovery.2060683  - run: Successfully terminated discovery process
