2025-11-26 18:45:12,872 - INFO - ya.test.2335202  - pytest_runtest_setup: ####################################################################################################
2025-11-26 18:45:12,873 - INFO - ya.test.2335202  - pytest_runtest_setup: test_json_success
2025-11-26 18:45:12,873 - INFO - ya.test.2335202  - pytest_runtest_setup: ####################################################################################################
2025-11-26 18:45:12,873 - INFO - ya.test.2335202  - pytest_runtest_setup: Test setup
2025-11-26 18:45:12,874 - INFO - ya.test.2335202  - pytest_runtest_call: Test call (class_name: test_public_api.py::TestJsonExample, test_name: test_json_success)
2025-11-26 18:45:12,875 - DEBUG - ydb.connection.2335202  - _prepare_call: RpcState(CreateSession, 2556a049-b8b4-40e2-9bde-bda067cac8ec, ghrun-ihttfokzrq.auto.internal:64389): creating call state
2025-11-26 18:45:12,875 - DEBUG - ydb.connection.2335202  - _log_request: RpcState(CreateSession, 2556a049-b8b4-40e2-9bde-bda067cac8ec, ghrun-ihttfokzrq.auto.internal:64389): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 18:45:12,881 - DEBUG - ydb.connection.2335202  - _log_response: RpcState(CreateSession, 2556a049-b8b4-40e2-9bde-bda067cac8ec, ghrun-ihttfokzrq.auto.internal:64389): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=ZmI4ZDUxOTgtNmIwMGM3ZjQtODY2OGRmNDctODdiY2I1MA==" } } } }
2025-11-26 18:45:12,882 - DEBUG - ydb.connection.2335202  - _prepare_call: RpcState(CreateTable, dcce3463-1677-47e3-9bb0-a0e5a91fe312, ghrun-ihttfokzrq.auto.internal:64389): creating call state
2025-11-26 18:45:12,883 - DEBUG - ydb.connection.2335202  - _log_request: RpcState(CreateTable, dcce3463-1677-47e3-9bb0-a0e5a91fe312, ghrun-ihttfokzrq.auto.internal:64389): request = { session_id: "ydb://session/3?node_id=1&id=ZmI4ZDUxOTgtNmIwMGM3ZjQtODY2OGRmNDctODdiY2I1MA==" path: "/Root/test_json_success" columns { name: "key" type { optional_type { item { type_id: UTF8 } } } } columns { name: "value" type { optional_type { item { type_id: JSON } } } } primary_key: "key" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 18:45:12,917 - DEBUG - ydb.connection.2335202  - _log_response: RpcState(CreateTable, dcce3463-1677-47e3-9bb0-a0e5a91fe312, ghrun-ihttfokzrq.auto.internal:64389): response = { operation { ready: true status: SUCCESS } }
2025-11-26 18:45:12,918 - DEBUG - ydb.connection.2335202  - _prepare_call: RpcState(PrepareDataQuery, e92a2650-879c-4664-b4c5-f965934eaf8e, ghrun-ihttfokzrq.auto.internal:64389): creating call state
2025-11-26 18:45:12,918 - DEBUG - ydb.connection.2335202  - _log_request: RpcState(PrepareDataQuery, e92a2650-879c-4664-b4c5-f965934eaf8e, ghrun-ihttfokzrq.auto.internal:64389): request = { session_id: "ydb://session/3?node_id=1&id=ZmI4ZDUxOTgtNmIwMGM3ZjQtODY2OGRmNDctODdiY2I1MA==" yql_text: "DECLARE $key as Utf8; \nDECLARE $value as Json; \nUPSERT INTO `/Root/test_json_success` (key, value) VALUES ($key, $value)" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 18:45:12,933 - DEBUG - ydb.connection.2335202  - _log_response: RpcState(PrepareDataQuery, e92a2650-879c-4664-b4c5-f965934eaf8e, ghrun-ihttfokzrq.auto.internal:64389): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.PrepareQueryResult] { query_id: "ydb://preparedqueryid/4?id=81bef3a2-8392b0ab-90171ac3-d568d079" parameters_types { key: "$key" value { type_id: UTF8 } } parameters_types { key: "$value" value { type_id: JSON } } } } } }
2025-11-26 18:45:12,934 - DEBUG - ydb.connection.2335202  - _prepare_call: RpcState(ExecuteDataQuery, aae0ba67-224d-4023-a16d-680b98699111, ghrun-ihttfokzrq.auto.internal:64389): creating call state
2025-11-26 18:45:12,936 - DEBUG - ydb.connection.2335202  - _log_request: RpcState(ExecuteDataQuery, aae0ba67-224d-4023-a16d-680b98699111, ghrun-ihttfokzrq.auto.internal:64389): request = { session_id: "ydb://session/3?node_id=1&id=ZmI4ZDUxOTgtNmIwMGM3ZjQtODY2OGRmNDctODdiY2I1MA==" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "DECLARE $key as Utf8; \nDECLARE $value as Json; \nUPSERT INTO `/Root/test_json_success` (key, value) VALUES ($key, $value)" } parameters { key: "$key" value { type { type_id: UTF8 } value { text_value: "one" } } } parameters { key: "$value" value { type { type_id: JSON } value { text_value: "{\"one\": 1}" } } } query_cache_policy { keep_in_cache: true } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 18:45:12,944 - DEBUG - ydb.connection.2335202  - _log_response: RpcState(ExecuteDataQuery, aae0ba67-224d-4023-a16d-680b98699111, ghrun-ihttfokzrq.auto.internal:64389): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } query_meta { id: "ydb://preparedqueryid/4?id=ec834fb4-6d2cfde8-23651919-62227ea7" parameters_types { key: "$key" value { type_id: UTF8 } } parameters_types { key: "$value" value { type_id: JSON } } } } } } }
2025-11-26 18:45:12,966 - INFO - ya.test.2335202  - pytest_runtest_teardown: Test teardown
2025-11-26 18:45:14,294 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335202  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-26 18:45:14,294 - DEBUG - ydb.connection.2335202  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-26 18:45:15,540 - DEBUG - ydb.connection.2335202  - close: Closing channel for endpoint localhost:22063
2025-11-26 18:45:15,556 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335202  - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:22063". Check endpoint correctness.
2025-11-26 18:45:17,283 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335202  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-26 18:45:17,283 - DEBUG - ydb.connection.2335202  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-26 18:45:24,298 - DEBUG - ydb.connection.2335202  - close: Closing channel for endpoint localhost:11726
2025-11-26 18:45:24,496 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335202  - _add_debug_details: Failed to establish connection to YDB discovery endpoint: "localhost:11726". Check endpoint correctness.
2025-11-26 18:45:24,971 - INFO - ydb.tests.library.harness.kikimr_runner.2335202  - stop: Stopped node localhost:64389/1
2025-11-26 18:45:24,983 - DEBUG - library.python.filelock.2335202  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/2061
2025-11-26 18:45:24,983 - DEBUG - library.python.filelock.2335202  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/7304
2025-11-26 18:45:24,984 - DEBUG - library.python.filelock.2335202  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/1285
2025-11-26 18:45:24,984 - DEBUG - library.python.filelock.2335202  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/64389
2025-11-26 18:45:24,984 - DEBUG - library.python.filelock.2335202  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/61683
2025-11-26 18:45:24,984 - DEBUG - ydb.topic.2335202  - close: Close topic client
2025-11-26 18:45:24,985 - DEBUG - ydb.topic.2335202  - close: Topic client was closed
2025-11-26 18:45:24,985 - DEBUG - ydb.connection.2335202  - close: Closing channel for endpoint localhost:64389
2025-11-26 18:45:24,987 - DEBUG - ydb.connection.2335202  - close: Closing channel for endpoint ghrun-ihttfokzrq.auto.internal:64389
2025-11-26 18:45:24,991 - INFO - ydb.pool.Discovery.2335202  - run: Successfully terminated discovery process
