2025-11-26 18:41:40,496 - INFO - ya.test.2332018  - pytest_runtest_setup: ####################################################################################################
2025-11-26 18:41:40,496 - INFO - ya.test.2332018  - pytest_runtest_setup: test_does_not_prevent_predicate_many_preceders_pmp_for_write_predicates
2025-11-26 18:41:40,496 - INFO - ya.test.2332018  - pytest_runtest_setup: ####################################################################################################
2025-11-26 18:41:40,497 - INFO - ya.test.2332018  - pytest_runtest_setup: Test setup
2025-11-26 18:41:40,498 - INFO - ya.test.2332018  - pytest_runtest_call: Test call (class_name: test_isolation.py::TestTransactionIsolation, test_name: test_does_not_prevent_predicate_many_preceders_pmp_for_write_predicates)
2025-11-26 18:41:40,499 - DEBUG - ydb.connection.2332018  - _prepare_call: RpcState(CreateSession, 45afd0b7-b69c-4bcf-9f2a-bbbce1b11054, ghrun-ihttfokzrq.auto.internal:8570): creating call state
2025-11-26 18:41:40,499 - DEBUG - ydb.connection.2332018  - _log_request: RpcState(CreateSession, 45afd0b7-b69c-4bcf-9f2a-bbbce1b11054, ghrun-ihttfokzrq.auto.internal:8570): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 18:41:40,502 - DEBUG - ydb.connection.2332018  - _log_response: RpcState(CreateSession, 45afd0b7-b69c-4bcf-9f2a-bbbce1b11054, 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=MjlhNThmYS1hNTU0ODdiNS03Mjc2MjRjLTVlYmZjOGM4" } } } }
2025-11-26 18:41:40,503 - DEBUG - ydb.connection.2332018  - _prepare_call: RpcState(ExecuteSchemeQuery, 4e5f2b5b-8cc7-4d96-8b27-f198e05e5804, ghrun-ihttfokzrq.auto.internal:8570): creating call state
2025-11-26 18:41:40,504 - DEBUG - ydb.connection.2332018  - _log_request: RpcState(ExecuteSchemeQuery, 4e5f2b5b-8cc7-4d96-8b27-f198e05e5804, ghrun-ihttfokzrq.auto.internal:8570): request = { session_id: "ydb://session/3?node_id=1&id=MjlhNThmYS1hNTU0ODdiNS03Mjc2MjRjLTVlYmZjOGM4" yql_text: "create table test_does_not_prevent_predicate_many_preceders_pmp_for_write_predicates (id Int32, value Int32, primary key(id)); " operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 18:41:40,535 - DEBUG - ydb.connection.2332018  - _log_response: RpcState(ExecuteSchemeQuery, 4e5f2b5b-8cc7-4d96-8b27-f198e05e5804, ghrun-ihttfokzrq.auto.internal:8570): response = { operation { ready: true status: SUCCESS } }
2025-11-26 18:41:40,536 - DEBUG - ydb.connection.2332018  - _prepare_call: RpcState(ExecuteDataQuery, 99193279-c6dd-4ed1-8987-d62e369dcc48, ghrun-ihttfokzrq.auto.internal:8570): creating call state
2025-11-26 18:41:40,536 - DEBUG - ydb.connection.2332018  - _log_request: RpcState(ExecuteDataQuery, 99193279-c6dd-4ed1-8987-d62e369dcc48, ghrun-ihttfokzrq.auto.internal:8570): request = { session_id: "ydb://session/3?node_id=1&id=MjlhNThmYS1hNTU0ODdiNS03Mjc2MjRjLTVlYmZjOGM4" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "upsert into test_does_not_prevent_predicate_many_preceders_pmp_for_write_predicates (id, value) values (1, 10), (2, 20); " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 18:41:40,557 - DEBUG - ydb.connection.2332018  - _log_response: RpcState(ExecuteDataQuery, 99193279-c6dd-4ed1-8987-d62e369dcc48, 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:40,559 - DEBUG - ydb.connection.2332018  - _prepare_call: RpcState(ExecuteDataQuery, 383a1b45-20bc-4b56-9432-d7585ac4a1b4, ghrun-ihttfokzrq.auto.internal:8570): creating call state
2025-11-26 18:41:40,559 - DEBUG - ydb.connection.2332018  - _log_request: RpcState(ExecuteDataQuery, 383a1b45-20bc-4b56-9432-d7585ac4a1b4, ghrun-ihttfokzrq.auto.internal:8570): request = { session_id: "ydb://session/3?node_id=1&id=MjlhNThmYS1hNTU0ODdiNS03Mjc2MjRjLTVlYmZjOGM4" tx_control { begin_tx { serializable_read_write { } } } query { yql_text: "update test_does_not_prevent_predicate_many_preceders_pmp_for_write_predicates set value = value + 10;" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 18:41:40,584 - DEBUG - ydb.connection.2332018  - _log_response: RpcState(ExecuteDataQuery, 383a1b45-20bc-4b56-9432-d7585ac4a1b4, ghrun-ihttfokzrq.auto.internal:8570): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { id: "01kb0qh97691r08jk8zzqb16tb" } } } } }
2025-11-26 18:41:40,585 - DEBUG - ydb.connection.2332018  - _prepare_call: RpcState(ExecuteDataQuery, d39a5aef-b018-4700-acf5-6d8277fb5665, ghrun-ihttfokzrq.auto.internal:8570): creating call state
2025-11-26 18:41:40,586 - DEBUG - ydb.connection.2332018  - _log_request: RpcState(ExecuteDataQuery, d39a5aef-b018-4700-acf5-6d8277fb5665, ghrun-ihttfokzrq.auto.internal:8570): request = { session_id: "ydb://session/3?node_id=1&id=MjlhNThmYS1hNTU0ODdiNS03Mjc2MjRjLTVlYmZjOGM4" tx_control { begin_tx { serializable_read_write { } } } query { yql_text: "delete from test_does_not_prevent_predicate_many_preceders_pmp_for_write_predicates where value = 20;" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 18:41:40,614 - DEBUG - ydb.connection.2332018  - _log_response: RpcState(ExecuteDataQuery, d39a5aef-b018-4700-acf5-6d8277fb5665, ghrun-ihttfokzrq.auto.internal:8570): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { id: "01kb0qh98423n14gcxg0sh16ny" } } } } }
2025-11-26 18:41:40,615 - DEBUG - ydb.connection.2332018  - _prepare_call: RpcState(CommitTransaction, ecd53a2b-af80-405e-a793-feeaafdd62f1, ghrun-ihttfokzrq.auto.internal:8570): creating call state
2025-11-26 18:41:40,615 - DEBUG - ydb.connection.2332018  - _log_request: RpcState(CommitTransaction, ecd53a2b-af80-405e-a793-feeaafdd62f1, ghrun-ihttfokzrq.auto.internal:8570): request = { session_id: "ydb://session/3?node_id=1&id=MjlhNThmYS1hNTU0ODdiNS03Mjc2MjRjLTVlYmZjOGM4" tx_id: "01kb0qh97691r08jk8zzqb16tb" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 18:41:40,624 - DEBUG - ydb.connection.2332018  - _log_response: RpcState(CommitTransaction, ecd53a2b-af80-405e-a793-feeaafdd62f1, ghrun-ihttfokzrq.auto.internal:8570): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CommitTransactionResult] { } } } }
2025-11-26 18:41:40,625 - DEBUG - ydb.connection.2332018  - _prepare_call: RpcState(CommitTransaction, bb71db0a-13c5-486f-b400-8483bea7fde1, ghrun-ihttfokzrq.auto.internal:8570): creating call state
2025-11-26 18:41:40,625 - DEBUG - ydb.connection.2332018  - _log_request: RpcState(CommitTransaction, bb71db0a-13c5-486f-b400-8483bea7fde1, ghrun-ihttfokzrq.auto.internal:8570): request = { session_id: "ydb://session/3?node_id=1&id=MjlhNThmYS1hNTU0ODdiNS03Mjc2MjRjLTVlYmZjOGM4" tx_id: "01kb0qh98423n14gcxg0sh16ny" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 18:41:40,631 - DEBUG - ydb.connection.2332018  - _log_response: RpcState(CommitTransaction, bb71db0a-13c5-486f-b400-8483bea7fde1, ghrun-ihttfokzrq.auto.internal:8570): response = { operation { ready: true status: ABORTED issues { message: "Transaction locks invalidated. Table: `/Root/test_does_not_prevent_predicate_many_preceders_pmp_for_write_predicates`" issue_code: 2001 severity: 1 } } }
2025-11-26 18:41:40,633 - INFO - ya.test.2332018  - pytest_runtest_teardown: Test teardown
