2025-11-26 18:41:42,021 - INFO - ya.test.2332018  - pytest_runtest_setup: ####################################################################################################
2025-11-26 18:41:42,021 - INFO - ya.test.2332018  - pytest_runtest_setup: test_anti_dependency_cycles_g2
2025-11-26 18:41:42,021 - INFO - ya.test.2332018  - pytest_runtest_setup: ####################################################################################################
2025-11-26 18:41:42,021 - INFO - ya.test.2332018  - pytest_runtest_setup: Test setup
2025-11-26 18:41:42,023 - INFO - ya.test.2332018  - pytest_runtest_call: Test call (class_name: test_isolation.py::TestTransactionIsolation, test_name: test_anti_dependency_cycles_g2)
2025-11-26 18:41:42,024 - DEBUG - ydb.connection.2332018  - _prepare_call: RpcState(CreateSession, c6c23aaa-41c7-448d-800d-cbfd4216ff6f, ghrun-ihttfokzrq.auto.internal:8570): creating call state
2025-11-26 18:41:42,024 - DEBUG - ydb.connection.2332018  - _log_request: RpcState(CreateSession, c6c23aaa-41c7-448d-800d-cbfd4216ff6f, ghrun-ihttfokzrq.auto.internal:8570): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 18:41:42,027 - DEBUG - ydb.connection.2332018  - _log_response: RpcState(CreateSession, c6c23aaa-41c7-448d-800d-cbfd4216ff6f, ghrun-ihttfokzrq.auto.internal:8570): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=YWU5MjFjMDctN2RjY2U3NTAtZjYwYWUwYzAtNjMwNGI1YzI=" } } } }
2025-11-26 18:41:42,028 - DEBUG - ydb.connection.2332018  - _prepare_call: RpcState(ExecuteSchemeQuery, 23e11e63-53c2-49e7-b357-6b32a55e6928, ghrun-ihttfokzrq.auto.internal:8570): creating call state
2025-11-26 18:41:42,028 - DEBUG - ydb.connection.2332018  - _log_request: RpcState(ExecuteSchemeQuery, 23e11e63-53c2-49e7-b357-6b32a55e6928, ghrun-ihttfokzrq.auto.internal:8570): request = { session_id: "ydb://session/3?node_id=1&id=YWU5MjFjMDctN2RjY2U3NTAtZjYwYWUwYzAtNjMwNGI1YzI=" 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-11-26 18:41:42,052 - DEBUG - ydb.connection.2332018  - _log_response: RpcState(ExecuteSchemeQuery, 23e11e63-53c2-49e7-b357-6b32a55e6928, ghrun-ihttfokzrq.auto.internal:8570): response = { operation { ready: true status: SUCCESS } }
2025-11-26 18:41:42,053 - DEBUG - ydb.connection.2332018  - _prepare_call: RpcState(ExecuteDataQuery, 0f0a1725-628b-479c-9f29-12237c85fd79, ghrun-ihttfokzrq.auto.internal:8570): creating call state
2025-11-26 18:41:42,054 - DEBUG - ydb.connection.2332018  - _log_request: RpcState(ExecuteDataQuery, 0f0a1725-628b-479c-9f29-12237c85fd79, ghrun-ihttfokzrq.auto.internal:8570): request = { session_id: "ydb://session/3?node_id=1&id=YWU5MjFjMDctN2RjY2U3NTAtZjYwYWUwYzAtNjMwNGI1YzI=" 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-11-26 18:41:42,077 - DEBUG - ydb.connection.2332018  - _log_response: RpcState(ExecuteDataQuery, 0f0a1725-628b-479c-9f29-12237c85fd79, ghrun-ihttfokzrq.auto.internal:8570): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-26 18:41:42,084 - DEBUG - ydb.connection.2332018  - _prepare_call: RpcState(ExecuteDataQuery, a10cc202-955f-4738-8090-9bfbd54b0822, ghrun-ihttfokzrq.auto.internal:8570): creating call state
2025-11-26 18:41:42,084 - DEBUG - ydb.connection.2332018  - _log_request: RpcState(ExecuteDataQuery, a10cc202-955f-4738-8090-9bfbd54b0822, ghrun-ihttfokzrq.auto.internal:8570): request = { session_id: "ydb://session/3?node_id=1&id=YWU5MjFjMDctN2RjY2U3NTAtZjYwYWUwYzAtNjMwNGI1YzI=" 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-11-26 18:41:42,122 - DEBUG - ydb.connection.2332018  - _log_response: RpcState(ExecuteDataQuery, a10cc202-955f-4738-8090-9bfbd54b0822, ghrun-ihttfokzrq.auto.internal:8570): 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: "01kb0qhaq635h8ytp2gwm073cm" } } } } }
2025-11-26 18:41:42,122 - DEBUG - ydb.connection.2332018  - _prepare_call: RpcState(ExecuteDataQuery, 355dfd1b-d98c-45ee-bdc3-8c0cbc142ba6, ghrun-ihttfokzrq.auto.internal:8570): creating call state
2025-11-26 18:41:42,124 - DEBUG - ydb.connection.2332018  - _log_request: RpcState(ExecuteDataQuery, 355dfd1b-d98c-45ee-bdc3-8c0cbc142ba6, ghrun-ihttfokzrq.auto.internal:8570): request = { session_id: "ydb://session/3?node_id=1&id=YWU5MjFjMDctN2RjY2U3NTAtZjYwYWUwYzAtNjMwNGI1YzI=" 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-11-26 18:41:42,151 - DEBUG - ydb.connection.2332018  - _log_response: RpcState(ExecuteDataQuery, 355dfd1b-d98c-45ee-bdc3-8c0cbc142ba6, ghrun-ihttfokzrq.auto.internal:8570): 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: "01kb0qhar4famm1z9ck4na4ran" } } } } }
2025-11-26 18:41:42,152 - DEBUG - ydb.connection.2332018  - _prepare_call: RpcState(ExecuteDataQuery, adfd18c8-adbd-4451-a1e3-229d4e8f0a7d, ghrun-ihttfokzrq.auto.internal:8570): creating call state
2025-11-26 18:41:42,155 - DEBUG - ydb.connection.2332018  - _log_request: RpcState(ExecuteDataQuery, adfd18c8-adbd-4451-a1e3-229d4e8f0a7d, ghrun-ihttfokzrq.auto.internal:8570): request = { session_id: "ydb://session/3?node_id=1&id=YWU5MjFjMDctN2RjY2U3NTAtZjYwYWUwYzAtNjMwNGI1YzI=" tx_control { tx_id: "01kb0qhaq635h8ytp2gwm073cm" } 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-11-26 18:41:42,170 - DEBUG - ydb.connection.2332018  - _log_response: RpcState(ExecuteDataQuery, adfd18c8-adbd-4451-a1e3-229d4e8f0a7d, ghrun-ihttfokzrq.auto.internal:8570): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { id: "01kb0qhaq635h8ytp2gwm073cm" } } } } }
2025-11-26 18:41:42,172 - DEBUG - ydb.connection.2332018  - _prepare_call: RpcState(ExecuteDataQuery, 386e4bb3-52de-45f9-bb04-521f6d66aacf, ghrun-ihttfokzrq.auto.internal:8570): creating call state
2025-11-26 18:41:42,172 - DEBUG - ydb.connection.2332018  - _log_request: RpcState(ExecuteDataQuery, 386e4bb3-52de-45f9-bb04-521f6d66aacf, ghrun-ihttfokzrq.auto.internal:8570): request = { session_id: "ydb://session/3?node_id=1&id=YWU5MjFjMDctN2RjY2U3NTAtZjYwYWUwYzAtNjMwNGI1YzI=" tx_control { tx_id: "01kb0qhar4famm1z9ck4na4ran" } 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-11-26 18:41:42,186 - DEBUG - ydb.connection.2332018  - _log_response: RpcState(ExecuteDataQuery, 386e4bb3-52de-45f9-bb04-521f6d66aacf, ghrun-ihttfokzrq.auto.internal:8570): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { id: "01kb0qhar4famm1z9ck4na4ran" } } } } }
2025-11-26 18:41:42,187 - DEBUG - ydb.connection.2332018  - _prepare_call: RpcState(CommitTransaction, d5dc8e12-ff09-47e3-a3a8-2305da97e76a, ghrun-ihttfokzrq.auto.internal:8570): creating call state
2025-11-26 18:41:42,187 - DEBUG - ydb.connection.2332018  - _log_request: RpcState(CommitTransaction, d5dc8e12-ff09-47e3-a3a8-2305da97e76a, ghrun-ihttfokzrq.auto.internal:8570): request = { session_id: "ydb://session/3?node_id=1&id=YWU5MjFjMDctN2RjY2U3NTAtZjYwYWUwYzAtNjMwNGI1YzI=" tx_id: "01kb0qhaq635h8ytp2gwm073cm" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 18:41:42,192 - DEBUG - ydb.connection.2332018  - _log_response: RpcState(CommitTransaction, d5dc8e12-ff09-47e3-a3a8-2305da97e76a, ghrun-ihttfokzrq.auto.internal:8570): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CommitTransactionResult] { } } } }
2025-11-26 18:41:42,193 - DEBUG - ydb.connection.2332018  - _prepare_call: RpcState(CommitTransaction, 31b8db77-65fa-466d-b251-bfc9ae6f10cd, ghrun-ihttfokzrq.auto.internal:8570): creating call state
2025-11-26 18:41:42,193 - DEBUG - ydb.connection.2332018  - _log_request: RpcState(CommitTransaction, 31b8db77-65fa-466d-b251-bfc9ae6f10cd, ghrun-ihttfokzrq.auto.internal:8570): request = { session_id: "ydb://session/3?node_id=1&id=YWU5MjFjMDctN2RjY2U3NTAtZjYwYWUwYzAtNjMwNGI1YzI=" tx_id: "01kb0qhar4famm1z9ck4na4ran" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 18:41:42,198 - DEBUG - ydb.connection.2332018  - _log_response: RpcState(CommitTransaction, 31b8db77-65fa-466d-b251-bfc9ae6f10cd, ghrun-ihttfokzrq.auto.internal:8570): 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-11-26 18:41:42,200 - INFO - ya.test.2332018  - pytest_runtest_teardown: Test teardown
