2025-10-31 15:41:10,471 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-31 15:41:10,471 - INFO - ya.test - pytest_runtest_setup: test_isolation_mailing_list_example
2025-10-31 15:41:10,471 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-31 15:41:10,471 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-31 15:41:10,473 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_isolation.py::TestTransactionIsolation, test_name: test_isolation_mailing_list_example)
2025-10-31 15:41:10,473 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 3c9f4a15-1173-41d5-9458-34f67ea9dc34, ghrun-xldpwfo7ey.auto.internal:6264): creating call state
2025-10-31 15:41:10,474 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 3c9f4a15-1173-41d5-9458-34f67ea9dc34, ghrun-xldpwfo7ey.auto.internal:6264): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 15:41:10,487 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 3c9f4a15-1173-41d5-9458-34f67ea9dc34, ghrun-xldpwfo7ey.auto.internal:6264): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=NDU1NTQzMi0xMTg2MDI3Ny0zMTQ0OGY3OS0zZGE4MjlmMQ==" } } } }
2025-10-31 15:41:10,488 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, ffb9a4ef-889c-41d4-a701-4f06af92097c, ghrun-xldpwfo7ey.auto.internal:6264): creating call state
2025-10-31 15:41:10,488 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, ffb9a4ef-889c-41d4-a701-4f06af92097c, ghrun-xldpwfo7ey.auto.internal:6264): request = { session_id: "ydb://session/3?node_id=1&id=NDU1NTQzMi0xMTg2MDI3Ny0zMTQ0OGY3OS0zZGE4MjlmMQ==" yql_text: "create table test_isolation_mailing_list_example (id Int32, value Int32, primary key(id)); " operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 15:41:10,537 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, ffb9a4ef-889c-41d4-a701-4f06af92097c, ghrun-xldpwfo7ey.auto.internal:6264): response = { operation { ready: true status: SUCCESS } }
2025-10-31 15:41:10,538 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, e44e3113-2abd-4e90-bde3-ab27f1f02ecd, ghrun-xldpwfo7ey.auto.internal:6264): creating call state
2025-10-31 15:41:10,577 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, e44e3113-2abd-4e90-bde3-ab27f1f02ecd, ghrun-xldpwfo7ey.auto.internal:6264): request = { session_id: "ydb://session/3?node_id=1&id=NDU1NTQzMi0xMTg2MDI3Ny0zMTQ0OGY3OS0zZGE4MjlmMQ==" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "upsert into test_isolation_mailing_list_example (id, value) values (1, 10), (2, 20); " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 15:41:10,594 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, e44e3113-2abd-4e90-bde3-ab27f1f02ecd, ghrun-xldpwfo7ey.auto.internal:6264): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-10-31 15:41:10,647 - DEBUG - ydb.connection - _prepare_call: RpcState(PrepareDataQuery, 50ff4a68-f61e-4c56-8311-fc8fe7a43ee1, ghrun-xldpwfo7ey.auto.internal:6264): creating call state
2025-10-31 15:41:10,648 - DEBUG - ydb.connection - _log_request: RpcState(PrepareDataQuery, 50ff4a68-f61e-4c56-8311-fc8fe7a43ee1, ghrun-xldpwfo7ey.auto.internal:6264): request = { session_id: "ydb://session/3?node_id=1&id=NDU1NTQzMi0xMTg2MDI3Ny0zMTQ0OGY3OS0zZGE4MjlmMQ==" yql_text: " upsert into test_isolation_mailing_list_example (id, value) values (1, 3);" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 15:41:10,667 - DEBUG - ydb.connection - _log_response: RpcState(PrepareDataQuery, 50ff4a68-f61e-4c56-8311-fc8fe7a43ee1, ghrun-xldpwfo7ey.auto.internal:6264): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.PrepareQueryResult] { query_id: "ydb://preparedqueryid/4?id=eccfb45c-19a901b0-b06c12d7-97e725fb" } } } }
2025-10-31 15:41:10,668 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, dd458f12-9d22-4742-a427-979607b387f9, ghrun-xldpwfo7ey.auto.internal:6264): creating call state
2025-10-31 15:41:10,669 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, dd458f12-9d22-4742-a427-979607b387f9, ghrun-xldpwfo7ey.auto.internal:6264): request = { session_id: "ydb://session/3?node_id=1&id=NDU1NTQzMi0xMTg2MDI3Ny0zMTQ0OGY3OS0zZGE4MjlmMQ==" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: " upsert into test_isolation_mailing_list_example (id, value) values (1, 3);" } query_cache_policy { keep_in_cache: true } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 15:41:10,673 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, dd458f12-9d22-4742-a427-979607b387f9, ghrun-xldpwfo7ey.auto.internal:6264): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } query_meta { id: "ydb://preparedqueryid/4?id=eccfb45c-19a901b0-b06c12d7-97e725fb" } } } } }
2025-10-31 15:41:10,681 - DEBUG - ydb.connection - _prepare_call: RpcState(PrepareDataQuery, 7c996b28-1691-4902-8e36-c0366259c01c, ghrun-xldpwfo7ey.auto.internal:6264): creating call state
2025-10-31 15:41:10,682 - DEBUG - ydb.connection - _log_request: RpcState(PrepareDataQuery, 7c996b28-1691-4902-8e36-c0366259c01c, ghrun-xldpwfo7ey.auto.internal:6264): request = { session_id: "ydb://session/3?node_id=1&id=NDU1NTQzMi0xMTg2MDI3Ny0zMTQ0OGY3OS0zZGE4MjlmMQ==" yql_text: " select id, value FROM test_isolation_mailing_list_example WHERE id = 1" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 15:41:10,701 - DEBUG - ydb.connection - _log_response: RpcState(PrepareDataQuery, 7c996b28-1691-4902-8e36-c0366259c01c, ghrun-xldpwfo7ey.auto.internal:6264): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.PrepareQueryResult] { query_id: "ydb://preparedqueryid/4?id=2365dd5-7d475cfe-3c66a6ec-c5153739" } } } }
2025-10-31 15:41:10,702 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 7972415f-ca11-4c0e-aa7d-5f7076cc805b, ghrun-xldpwfo7ey.auto.internal:6264): creating call state
2025-10-31 15:41:10,704 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 7972415f-ca11-4c0e-aa7d-5f7076cc805b, ghrun-xldpwfo7ey.auto.internal:6264): request = { session_id: "ydb://session/3?node_id=1&id=NDU1NTQzMi0xMTg2MDI3Ny0zMTQ0OGY3OS0zZGE4MjlmMQ==" tx_control { begin_tx { serializable_read_write { } } } query { yql_text: " select id, value FROM test_isolation_mailing_list_example WHERE id = 1" } query_cache_policy { keep_in_cache: true } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 15:41:10,718 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 7972415f-ca11-4c0e-aa7d-5f7076cc805b, ghrun-xldpwfo7ey.auto.internal:6264): 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: 3 } } format: FORMAT_VALUE } tx_meta { id: "01k8xew35vcnw3ygda6kedx9tk" } query_meta { id: "ydb://preparedqueryid/4?id=2365dd5-7d475cfe-3c66a6ec-c5153739" } } } } }
2025-10-31 15:41:10,743 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 2cb3bd08-13a7-4cc3-a085-3841eb04e6f5, ghrun-xldpwfo7ey.auto.internal:6264): creating call state
2025-10-31 15:41:10,744 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 2cb3bd08-13a7-4cc3-a085-3841eb04e6f5, ghrun-xldpwfo7ey.auto.internal:6264): request = { session_id: "ydb://session/3?node_id=1&id=NDU1NTQzMi0xMTg2MDI3Ny0zMTQ0OGY3OS0zZGE4MjlmMQ==" tx_control { begin_tx { serializable_read_write { } } } query { yql_text: " select id, value FROM test_isolation_mailing_list_example WHERE id = 1" } query_cache_policy { keep_in_cache: true } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 15:41:10,749 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 2cb3bd08-13a7-4cc3-a085-3841eb04e6f5, ghrun-xldpwfo7ey.auto.internal:6264): 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: 3 } } format: FORMAT_VALUE } tx_meta { id: "01k8xew36sd8jpbfz0445grh2n" } query_meta { id: "ydb://preparedqueryid/4?id=2365dd5-7d475cfe-3c66a6ec-c5153739" } } } } }
2025-10-31 15:41:10,753 - DEBUG - ydb.connection - _prepare_call: RpcState(PrepareDataQuery, b9d1006f-89b5-416e-a7a8-5f231b147e2e, ghrun-xldpwfo7ey.auto.internal:6264): creating call state
2025-10-31 15:41:10,756 - DEBUG - ydb.connection - _log_request: RpcState(PrepareDataQuery, b9d1006f-89b5-416e-a7a8-5f231b147e2e, ghrun-xldpwfo7ey.auto.internal:6264): request = { session_id: "ydb://session/3?node_id=1&id=NDU1NTQzMi0xMTg2MDI3Ny0zMTQ0OGY3OS0zZGE4MjlmMQ==" yql_text: " upsert into test_isolation_mailing_list_example (id, value) values (1, 4);" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 15:41:10,770 - DEBUG - ydb.connection - _log_response: RpcState(PrepareDataQuery, b9d1006f-89b5-416e-a7a8-5f231b147e2e, ghrun-xldpwfo7ey.auto.internal:6264): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.PrepareQueryResult] { query_id: "ydb://preparedqueryid/4?id=bec91d48-844c25d4-5592e162-b6de74e5" } } } }
2025-10-31 15:41:10,773 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 8310fa27-2cb7-4e73-823c-eae4e6d5ec1e, ghrun-xldpwfo7ey.auto.internal:6264): creating call state
2025-10-31 15:41:10,773 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 8310fa27-2cb7-4e73-823c-eae4e6d5ec1e, ghrun-xldpwfo7ey.auto.internal:6264): request = { session_id: "ydb://session/3?node_id=1&id=NDU1NTQzMi0xMTg2MDI3Ny0zMTQ0OGY3OS0zZGE4MjlmMQ==" tx_control { tx_id: "01k8xew35vcnw3ygda6kedx9tk" } query { yql_text: " upsert into test_isolation_mailing_list_example (id, value) values (1, 4);" } query_cache_policy { keep_in_cache: true } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 15:41:10,776 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 8310fa27-2cb7-4e73-823c-eae4e6d5ec1e, ghrun-xldpwfo7ey.auto.internal:6264): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { id: "01k8xew35vcnw3ygda6kedx9tk" } query_meta { id: "ydb://preparedqueryid/4?id=bec91d48-844c25d4-5592e162-b6de74e5" } } } } }
2025-10-31 15:41:10,777 - DEBUG - ydb.connection - _prepare_call: RpcState(CommitTransaction, 02a457b2-9e3e-44fe-b857-6c6c4be1da2a, ghrun-xldpwfo7ey.auto.internal:6264): creating call state
2025-10-31 15:41:10,777 - DEBUG - ydb.connection - _log_request: RpcState(CommitTransaction, 02a457b2-9e3e-44fe-b857-6c6c4be1da2a, ghrun-xldpwfo7ey.auto.internal:6264): request = { session_id: "ydb://session/3?node_id=1&id=NDU1NTQzMi0xMTg2MDI3Ny0zMTQ0OGY3OS0zZGE4MjlmMQ==" tx_id: "01k8xew35vcnw3ygda6kedx9tk" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 15:41:10,784 - DEBUG - ydb.connection - _log_response: RpcState(CommitTransaction, 02a457b2-9e3e-44fe-b857-6c6c4be1da2a, ghrun-xldpwfo7ey.auto.internal:6264): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CommitTransactionResult] { } } } }
2025-10-31 15:41:10,794 - DEBUG - ydb.connection - _prepare_call: RpcState(PrepareDataQuery, 95d7b4fa-e7e7-423e-8ccc-5f1aebe7bbcc, ghrun-xldpwfo7ey.auto.internal:6264): creating call state
2025-10-31 15:41:10,794 - DEBUG - ydb.connection - _log_request: RpcState(PrepareDataQuery, 95d7b4fa-e7e7-423e-8ccc-5f1aebe7bbcc, ghrun-xldpwfo7ey.auto.internal:6264): request = { session_id: "ydb://session/3?node_id=1&id=NDU1NTQzMi0xMTg2MDI3Ny0zMTQ0OGY3OS0zZGE4MjlmMQ==" yql_text: " upsert into test_isolation_mailing_list_example (id, value) values (1, 5);" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 15:41:10,809 - DEBUG - ydb.connection - _log_response: RpcState(PrepareDataQuery, 95d7b4fa-e7e7-423e-8ccc-5f1aebe7bbcc, ghrun-xldpwfo7ey.auto.internal:6264): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.PrepareQueryResult] { query_id: "ydb://preparedqueryid/4?id=85e8629f-5b44818d-2ccbd8d6-cf81d133" } } } }
2025-10-31 15:41:10,814 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, ea02c234-2739-4e76-bd66-56b4ad1b05ff, ghrun-xldpwfo7ey.auto.internal:6264): creating call state
2025-10-31 15:41:10,815 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, ea02c234-2739-4e76-bd66-56b4ad1b05ff, ghrun-xldpwfo7ey.auto.internal:6264): request = { session_id: "ydb://session/3?node_id=1&id=NDU1NTQzMi0xMTg2MDI3Ny0zMTQ0OGY3OS0zZGE4MjlmMQ==" tx_control { tx_id: "01k8xew36sd8jpbfz0445grh2n" } query { yql_text: " upsert into test_isolation_mailing_list_example (id, value) values (1, 5);" } query_cache_policy { keep_in_cache: true } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 15:41:10,818 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, ea02c234-2739-4e76-bd66-56b4ad1b05ff, ghrun-xldpwfo7ey.auto.internal:6264): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { id: "01k8xew36sd8jpbfz0445grh2n" } query_meta { id: "ydb://preparedqueryid/4?id=85e8629f-5b44818d-2ccbd8d6-cf81d133" } } } } }
2025-10-31 15:41:10,822 - DEBUG - ydb.connection - _prepare_call: RpcState(CommitTransaction, 7ab5b316-6b9a-4f51-9851-ba087e24a63a, ghrun-xldpwfo7ey.auto.internal:6264): creating call state
2025-10-31 15:41:10,824 - DEBUG - ydb.connection - _log_request: RpcState(CommitTransaction, 7ab5b316-6b9a-4f51-9851-ba087e24a63a, ghrun-xldpwfo7ey.auto.internal:6264): request = { session_id: "ydb://session/3?node_id=1&id=NDU1NTQzMi0xMTg2MDI3Ny0zMTQ0OGY3OS0zZGE4MjlmMQ==" tx_id: "01k8xew36sd8jpbfz0445grh2n" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 15:41:10,841 - DEBUG - ydb.connection - _log_response: RpcState(CommitTransaction, 7ab5b316-6b9a-4f51-9851-ba087e24a63a, ghrun-xldpwfo7ey.auto.internal:6264): response = { operation { ready: true status: ABORTED issues { message: "Transaction locks invalidated. Table: `/Root/test_isolation_mailing_list_example`." issue_code: 2001 severity: 1 issues { message: "Operation is aborting because locks are not valid" issue_code: 2001 severity: 1 } } } }
2025-10-31 15:41:10,866 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 707d8a39-aa5b-4144-9519-58c2a2efbac5, ghrun-xldpwfo7ey.auto.internal:6264): creating call state
2025-10-31 15:41:10,866 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 707d8a39-aa5b-4144-9519-58c2a2efbac5, ghrun-xldpwfo7ey.auto.internal:6264): request = { session_id: "ydb://session/3?node_id=1&id=NDU1NTQzMi0xMTg2MDI3Ny0zMTQ0OGY3OS0zZGE4MjlmMQ==" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: " select id, value from test_isolation_mailing_list_example where id = 1;" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 15:41:10,895 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 707d8a39-aa5b-4144-9519-58c2a2efbac5, ghrun-xldpwfo7ey.auto.internal:6264): 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: 4 } } format: FORMAT_VALUE } tx_meta { } } } } }
2025-10-31 15:41:10,897 - INFO - ya.test - pytest_runtest_teardown: Test teardown
