2026-03-25 17:14:54,977 - INFO - ya.test.2499227  - pytest_runtest_setup: ####################################################################################################
2026-03-25 17:14:54,977 - INFO - ya.test.2499227  - pytest_runtest_setup: test_anti_dependency_cycles_g2_two_edges
2026-03-25 17:14:54,977 - INFO - ya.test.2499227  - pytest_runtest_setup: ####################################################################################################
2026-03-25 17:14:54,977 - INFO - ya.test.2499227  - pytest_runtest_setup: Test setup
2026-03-25 17:14:54,978 - INFO - ya.test.2499227  - pytest_runtest_call: Test call (class_name: test_isolation.py::TestTransactionIsolation, test_name: test_anti_dependency_cycles_g2_two_edges)
2026-03-25 17:14:54,978 - DEBUG - ydb.connection.2499227  - _prepare_call: RpcState(CreateSession, f50d48b2-8c9b-47c6-a6fc-c148482ea653, ghrun-ve2ie6ihly.auto.internal:65362): creating call state
2026-03-25 17:14:54,978 - DEBUG - ydb.connection.2499227  - _log_request: RpcState(CreateSession, f50d48b2-8c9b-47c6-a6fc-c148482ea653, ghrun-ve2ie6ihly.auto.internal:65362): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2026-03-25 17:14:54,980 - DEBUG - ydb.connection.2499227  - _log_response: RpcState(CreateSession, f50d48b2-8c9b-47c6-a6fc-c148482ea653, 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=NWFjZmI0ZjktNjJiZTA2My0yOWMxZTFjMC04MjM3ZmZlOA%3D%3D" } } } }
2026-03-25 17:14:54,980 - DEBUG - ydb.connection.2499227  - _prepare_call: RpcState(ExecuteSchemeQuery, 8fddec94-9d5d-4772-ae23-8e2163001e87, ghrun-ve2ie6ihly.auto.internal:65362): creating call state
2026-03-25 17:14:54,981 - DEBUG - ydb.connection.2499227  - _log_request: RpcState(ExecuteSchemeQuery, 8fddec94-9d5d-4772-ae23-8e2163001e87, ghrun-ve2ie6ihly.auto.internal:65362): request = { session_id: "ydb://session/3?node_id=1&id=NWFjZmI0ZjktNjJiZTA2My0yOWMxZTFjMC04MjM3ZmZlOA%3D%3D" 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 } } }
2026-03-25 17:14:54,999 - DEBUG - ydb.connection.2499227  - _log_response: RpcState(ExecuteSchemeQuery, 8fddec94-9d5d-4772-ae23-8e2163001e87, ghrun-ve2ie6ihly.auto.internal:65362): response = { operation { ready: true status: SUCCESS } }
2026-03-25 17:14:55,000 - DEBUG - ydb.connection.2499227  - _prepare_call: RpcState(ExecuteDataQuery, 516729cb-e22b-40c9-b655-52c567ff6094, ghrun-ve2ie6ihly.auto.internal:65362): creating call state
2026-03-25 17:14:55,000 - DEBUG - ydb.connection.2499227  - _log_request: RpcState(ExecuteDataQuery, 516729cb-e22b-40c9-b655-52c567ff6094, ghrun-ve2ie6ihly.auto.internal:65362): request = { session_id: "ydb://session/3?node_id=1&id=NWFjZmI0ZjktNjJiZTA2My0yOWMxZTFjMC04MjM3ZmZlOA%3D%3D" 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 } } }
2026-03-25 17:14:55,013 - DEBUG - ydb.connection.2499227  - _log_response: RpcState(ExecuteDataQuery, 516729cb-e22b-40c9-b655-52c567ff6094, 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:55,014 - DEBUG - ydb.connection.2499227  - _prepare_call: RpcState(ExecuteDataQuery, ba2342a9-f43d-44a1-80ab-38c4885ff4ee, ghrun-ve2ie6ihly.auto.internal:65362): creating call state
2026-03-25 17:14:55,014 - DEBUG - ydb.connection.2499227  - _log_request: RpcState(ExecuteDataQuery, ba2342a9-f43d-44a1-80ab-38c4885ff4ee, ghrun-ve2ie6ihly.auto.internal:65362): request = { session_id: "ydb://session/3?node_id=1&id=NWFjZmI0ZjktNjJiZTA2My0yOWMxZTFjMC04MjM3ZmZlOA%3D%3D" 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 } } }
2026-03-25 17:14:55,032 - DEBUG - ydb.connection.2499227  - _log_response: RpcState(ExecuteDataQuery, ba2342a9-f43d-44a1-80ab-38c4885ff4ee, 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 } } rows { items { int32_value: 2 } items { int32_value: 20 } } format: FORMAT_VALUE } tx_meta { id: "01kmjzvynpet1e3wy8v6201t8h" } } } } }
2026-03-25 17:14:55,033 - DEBUG - ydb.connection.2499227  - _prepare_call: RpcState(ExecuteDataQuery, 2e14edb9-6c32-4294-909f-c409ce560415, ghrun-ve2ie6ihly.auto.internal:65362): creating call state
2026-03-25 17:14:55,034 - DEBUG - ydb.connection.2499227  - _log_request: RpcState(ExecuteDataQuery, 2e14edb9-6c32-4294-909f-c409ce560415, ghrun-ve2ie6ihly.auto.internal:65362): request = { session_id: "ydb://session/3?node_id=1&id=NWFjZmI0ZjktNjJiZTA2My0yOWMxZTFjMC04MjM3ZmZlOA%3D%3D" 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 } } }
2026-03-25 17:14:55,053 - DEBUG - ydb.connection.2499227  - _log_response: RpcState(ExecuteDataQuery, 2e14edb9-6c32-4294-909f-c409ce560415, ghrun-ve2ie6ihly.auto.internal:65362): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { id: "01kmjzvypb7t9ztecf49p5vd8y" } } } } }
2026-03-25 17:14:55,053 - DEBUG - ydb.connection.2499227  - _prepare_call: RpcState(CommitTransaction, d3e7133f-9a00-4834-b865-74fba6f3d0b6, ghrun-ve2ie6ihly.auto.internal:65362): creating call state
2026-03-25 17:14:55,053 - DEBUG - ydb.connection.2499227  - _log_request: RpcState(CommitTransaction, d3e7133f-9a00-4834-b865-74fba6f3d0b6, ghrun-ve2ie6ihly.auto.internal:65362): request = { session_id: "ydb://session/3?node_id=1&id=NWFjZmI0ZjktNjJiZTA2My0yOWMxZTFjMC04MjM3ZmZlOA%3D%3D" tx_id: "01kmjzvypb7t9ztecf49p5vd8y" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2026-03-25 17:14:55,058 - DEBUG - ydb.connection.2499227  - _log_response: RpcState(CommitTransaction, d3e7133f-9a00-4834-b865-74fba6f3d0b6, ghrun-ve2ie6ihly.auto.internal:65362): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CommitTransactionResult] { } } } }
2026-03-25 17:14:55,059 - DEBUG - ydb.connection.2499227  - _prepare_call: RpcState(ExecuteDataQuery, cc8492fa-3730-4337-a684-de2f75aacb08, ghrun-ve2ie6ihly.auto.internal:65362): creating call state
2026-03-25 17:14:55,059 - DEBUG - ydb.connection.2499227  - _log_request: RpcState(ExecuteDataQuery, cc8492fa-3730-4337-a684-de2f75aacb08, ghrun-ve2ie6ihly.auto.internal:65362): request = { session_id: "ydb://session/3?node_id=1&id=NWFjZmI0ZjktNjJiZTA2My0yOWMxZTFjMC04MjM3ZmZlOA%3D%3D" 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 } } }
2026-03-25 17:14:55,081 - DEBUG - ydb.connection.2499227  - _log_response: RpcState(ExecuteDataQuery, cc8492fa-3730-4337-a684-de2f75aacb08, 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 } } rows { items { int32_value: 2 } items { int32_value: 25 } } format: FORMAT_VALUE } tx_meta { id: "01kmjzvyq59q1f13n4z1b9dfk3" } } } } }
2026-03-25 17:14:55,081 - DEBUG - ydb.connection.2499227  - _prepare_call: RpcState(CommitTransaction, 36bcf36e-f8e7-4f5b-95d0-0ce6f08a1cd4, ghrun-ve2ie6ihly.auto.internal:65362): creating call state
2026-03-25 17:14:55,082 - DEBUG - ydb.connection.2499227  - _log_request: RpcState(CommitTransaction, 36bcf36e-f8e7-4f5b-95d0-0ce6f08a1cd4, ghrun-ve2ie6ihly.auto.internal:65362): request = { session_id: "ydb://session/3?node_id=1&id=NWFjZmI0ZjktNjJiZTA2My0yOWMxZTFjMC04MjM3ZmZlOA%3D%3D" tx_id: "01kmjzvyq59q1f13n4z1b9dfk3" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2026-03-25 17:14:55,083 - DEBUG - ydb.connection.2499227  - _log_response: RpcState(CommitTransaction, 36bcf36e-f8e7-4f5b-95d0-0ce6f08a1cd4, ghrun-ve2ie6ihly.auto.internal:65362): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CommitTransactionResult] { } } } }
2026-03-25 17:14:55,084 - DEBUG - ydb.connection.2499227  - _prepare_call: RpcState(ExecuteDataQuery, bf843847-7ba7-410c-b094-b4ffde5d3c79, ghrun-ve2ie6ihly.auto.internal:65362): creating call state
2026-03-25 17:14:55,084 - DEBUG - ydb.connection.2499227  - _log_request: RpcState(ExecuteDataQuery, bf843847-7ba7-410c-b094-b4ffde5d3c79, ghrun-ve2ie6ihly.auto.internal:65362): request = { session_id: "ydb://session/3?node_id=1&id=NWFjZmI0ZjktNjJiZTA2My0yOWMxZTFjMC04MjM3ZmZlOA%3D%3D" tx_control { tx_id: "01kmjzvynpet1e3wy8v6201t8h" } 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 } } }
2026-03-25 17:14:55,108 - DEBUG - ydb.connection.2499227  - _log_response: RpcState(ExecuteDataQuery, bf843847-7ba7-410c-b094-b4ffde5d3c79, ghrun-ve2ie6ihly.auto.internal:65362): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { id: "01kmjzvynpet1e3wy8v6201t8h" } } } } }
2026-03-25 17:14:55,109 - DEBUG - ydb.connection.2499227  - _prepare_call: RpcState(CommitTransaction, ce255d52-73dc-4998-a50c-57e480a06e86, ghrun-ve2ie6ihly.auto.internal:65362): creating call state
2026-03-25 17:14:55,109 - DEBUG - ydb.connection.2499227  - _log_request: RpcState(CommitTransaction, ce255d52-73dc-4998-a50c-57e480a06e86, ghrun-ve2ie6ihly.auto.internal:65362): request = { session_id: "ydb://session/3?node_id=1&id=NWFjZmI0ZjktNjJiZTA2My0yOWMxZTFjMC04MjM3ZmZlOA%3D%3D" tx_id: "01kmjzvynpet1e3wy8v6201t8h" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2026-03-25 17:14:55,112 - DEBUG - ydb.connection.2499227  - _log_response: RpcState(CommitTransaction, ce255d52-73dc-4998-a50c-57e480a06e86, ghrun-ve2ie6ihly.auto.internal:65362): 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 } } }
2026-03-25 17:14:55,114 - INFO - ya.test.2499227  - pytest_runtest_teardown: Test teardown
2026-03-25 17:15:17,115 - INFO - ydb.tests.library.harness.kikimr_runner.2499227  - stop: Stopped node localhost:65362/1
2026-03-25 17:15:17,117 - DEBUG - library.python.filelock.2499227  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/6001
2026-03-25 17:15:17,117 - DEBUG - library.python.filelock.2499227  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/15800
2026-03-25 17:15:17,118 - DEBUG - library.python.filelock.2499227  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/16235
2026-03-25 17:15:17,118 - DEBUG - library.python.filelock.2499227  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/65362
2026-03-25 17:15:17,118 - DEBUG - library.python.filelock.2499227  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/18005
2026-03-25 17:15:17,118 - DEBUG - ydb.topic.2499227  - close: Close topic client
2026-03-25 17:15:17,118 - DEBUG - ydb.topic.2499227  - close: Topic client was closed
2026-03-25 17:15:17,119 - DEBUG - ydb.connection.2499227  - close: Closing channel for endpoint localhost:65362
2026-03-25 17:15:17,119 - DEBUG - ydb.connection.2499227  - close: Closing channel for endpoint ghrun-ve2ie6ihly.auto.internal:65362
2026-03-25 17:15:17,119 - INFO - ydb.pool.Discovery.2499227  - run: Successfully terminated discovery process
