2025-10-27 12:38:16,618 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-27 12:38:16,619 - INFO - ya.test - pytest_runtest_setup: test_json_query
2025-10-27 12:38:16,619 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-27 12:38:16,619 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-27 12:38:16,623 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_select.py::TestSelect, test_name: test_json_query)
2025-10-27 12:38:16,630 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2QzMzA0MjAtYjdjZDEyZWMtZDVkZDhjNjktNzAxMWZkOWU=
2025-10-27 12:38:16,630 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9bc3eaf8-4453-453c-979b-0bcd77c020c6, ghrun-5rmqn7spre.auto.internal:8062): creating call state
2025-10-27 12:38:16,631 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9bc3eaf8-4453-453c-979b-0bcd77c020c6, ghrun-5rmqn7spre.auto.internal:8062): request = { session_id: "ydb://session/3?node_id=1&id=Y2QzMzA0MjAtYjdjZDEyZWMtZDVkZDhjNjktNzAxMWZkOWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            CREATE TABLE `/Root/select/table43386_js` (\n                id Uint64 NOT NULL,\n                vjs Json,\n                PRIMARY KEY(id),\n            )\n            WITH (\n                STORE = COLUMN\n            )\n            " } stats_mode: STATS_MODE_NONE }
2025-10-27 12:38:16,632 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9bc3eaf8-4453-453c-979b-0bcd77c020c6, ghrun-5rmqn7spre.auto.internal:8062): response = { <_MultiThreadedRendezvous object> }
2025-10-27 12:38:17,315 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2QzMzA0MjAtYjdjZDEyZWMtZDVkZDhjNjktNzAxMWZkOWU=
2025-10-27 12:38:17,335 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2QzMzA0MjAtYjdjZDEyZWMtZDVkZDhjNjktNzAxMWZkOWU=
2025-10-27 12:38:17,352 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 221d90b0-8352-4277-927d-4d574ffae662, ghrun-5rmqn7spre.auto.internal:8062): creating call state
2025-10-27 12:38:17,352 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 221d90b0-8352-4277-927d-4d574ffae662, ghrun-5rmqn7spre.auto.internal:8062): request = { session_id: "ydb://session/3?node_id=1&id=Y2QzMzA0MjAtYjdjZDEyZWMtZDVkZDhjNjktNzAxMWZkOWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "INSERT INTO `/Root/select/table43386_js` (id, vjs) VALUES (11, @@{\"vals\": [{\"vs\": \"a\", \"vn\": 1}]}@@);" } stats_mode: STATS_MODE_NONE }
2025-10-27 12:38:17,372 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 221d90b0-8352-4277-927d-4d574ffae662, ghrun-5rmqn7spre.auto.internal:8062): response = { <_MultiThreadedRendezvous object> }
2025-10-27 12:38:17,438 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2QzMzA0MjAtYjdjZDEyZWMtZDVkZDhjNjktNzAxMWZkOWU=
2025-10-27 12:38:17,473 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2QzMzA0MjAtYjdjZDEyZWMtZDVkZDhjNjktNzAxMWZkOWU=
2025-10-27 12:38:17,474 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d8a96b6a-3cbe-4f7b-bdeb-83709d743772, ghrun-5rmqn7spre.auto.internal:8062): creating call state
2025-10-27 12:38:17,509 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d8a96b6a-3cbe-4f7b-bdeb-83709d743772, ghrun-5rmqn7spre.auto.internal:8062): request = { session_id: "ydb://session/3?node_id=1&id=Y2QzMzA0MjAtYjdjZDEyZWMtZDVkZDhjNjktNzAxMWZkOWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "INSERT INTO `/Root/select/table43386_js` (id, vjs) VALUES (22, @@{\"vals\": [{\"vs\": \"b\", \"vn\": 2}]}@@);" } stats_mode: STATS_MODE_NONE }
2025-10-27 12:38:17,510 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d8a96b6a-3cbe-4f7b-bdeb-83709d743772, ghrun-5rmqn7spre.auto.internal:8062): response = { <_MultiThreadedRendezvous object> }
2025-10-27 12:38:17,554 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2QzMzA0MjAtYjdjZDEyZWMtZDVkZDhjNjktNzAxMWZkOWU=
2025-10-27 12:38:17,555 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2QzMzA0MjAtYjdjZDEyZWMtZDVkZDhjNjktNzAxMWZkOWU=
2025-10-27 12:38:17,555 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e8a07e9f-17d4-4611-b27d-979b82d7de84, ghrun-5rmqn7spre.auto.internal:8062): creating call state
2025-10-27 12:38:17,558 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e8a07e9f-17d4-4611-b27d-979b82d7de84, ghrun-5rmqn7spre.auto.internal:8062): request = { session_id: "ydb://session/3?node_id=1&id=Y2QzMzA0MjAtYjdjZDEyZWMtZDVkZDhjNjktNzAxMWZkOWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "INSERT INTO `/Root/select/table43386_js` (id, vjs) VALUES (33, @@{\"vals\": [{\"vs\": \"c\", \"vn\": 3}]}@@);" } stats_mode: STATS_MODE_NONE }
2025-10-27 12:38:17,559 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e8a07e9f-17d4-4611-b27d-979b82d7de84, ghrun-5rmqn7spre.auto.internal:8062): response = { <_MultiThreadedRendezvous object> }
2025-10-27 12:38:17,594 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2QzMzA0MjAtYjdjZDEyZWMtZDVkZDhjNjktNzAxMWZkOWU=
2025-10-27 12:38:17,604 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2QzMzA0MjAtYjdjZDEyZWMtZDVkZDhjNjktNzAxMWZkOWU=
2025-10-27 12:38:17,610 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c0f3d459-1ca0-4f2d-941b-b7c8b8895f07, ghrun-5rmqn7spre.auto.internal:8062): creating call state
2025-10-27 12:38:17,616 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c0f3d459-1ca0-4f2d-941b-b7c8b8895f07, ghrun-5rmqn7spre.auto.internal:8062): request = { session_id: "ydb://session/3?node_id=1&id=Y2QzMzA0MjAtYjdjZDEyZWMtZDVkZDhjNjktNzAxMWZkOWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT JSON_EXISTS(vjs, \"$.vals[*].vs\") AS e FROM `/Root/select/table43386_js`;" } stats_mode: STATS_MODE_NONE }
2025-10-27 12:38:17,619 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c0f3d459-1ca0-4f2d-941b-b7c8b8895f07, ghrun-5rmqn7spre.auto.internal:8062): response = { <_MultiThreadedRendezvous object> }
2025-10-27 12:38:17,771 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2QzMzA0MjAtYjdjZDEyZWMtZDVkZDhjNjktNzAxMWZkOWU=
2025-10-27 12:38:17,773 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2QzMzA0MjAtYjdjZDEyZWMtZDVkZDhjNjktNzAxMWZkOWU=
2025-10-27 12:38:17,773 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2259b041-4107-45e8-b759-9bc0a1f486a1, ghrun-5rmqn7spre.auto.internal:8062): creating call state
2025-10-27 12:38:17,774 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2259b041-4107-45e8-b759-9bc0a1f486a1, ghrun-5rmqn7spre.auto.internal:8062): request = { session_id: "ydb://session/3?node_id=1&id=Y2QzMzA0MjAtYjdjZDEyZWMtZDVkZDhjNjktNzAxMWZkOWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT JSON_EXISTS(vjs, \"$.vals[1].vs\") AS e FROM `/Root/select/table43386_js`;" } stats_mode: STATS_MODE_NONE }
2025-10-27 12:38:17,775 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2259b041-4107-45e8-b759-9bc0a1f486a1, ghrun-5rmqn7spre.auto.internal:8062): response = { <_MultiThreadedRendezvous object> }
2025-10-27 12:38:17,849 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2QzMzA0MjAtYjdjZDEyZWMtZDVkZDhjNjktNzAxMWZkOWU=
2025-10-27 12:38:17,879 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2QzMzA0MjAtYjdjZDEyZWMtZDVkZDhjNjktNzAxMWZkOWU=
2025-10-27 12:38:17,903 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fa04580e-141d-400e-9569-d3f62f873d93, ghrun-5rmqn7spre.auto.internal:8062): creating call state
2025-10-27 12:38:17,909 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fa04580e-141d-400e-9569-d3f62f873d93, ghrun-5rmqn7spre.auto.internal:8062): request = { session_id: "ydb://session/3?node_id=1&id=Y2QzMzA0MjAtYjdjZDEyZWMtZDVkZDhjNjktNzAxMWZkOWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT id FROM `/Root/select/table43386_js` WHERE JSON_VALUE(vjs, \"$.vals[0].vn\" RETURNING Int32) = 2;" } stats_mode: STATS_MODE_NONE }
2025-10-27 12:38:17,922 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fa04580e-141d-400e-9569-d3f62f873d93, ghrun-5rmqn7spre.auto.internal:8062): response = { <_MultiThreadedRendezvous object> }
2025-10-27 12:38:18,214 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2QzMzA0MjAtYjdjZDEyZWMtZDVkZDhjNjktNzAxMWZkOWU=
2025-10-27 12:38:18,220 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2QzMzA0MjAtYjdjZDEyZWMtZDVkZDhjNjktNzAxMWZkOWU=
2025-10-27 12:38:18,222 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 76ffcdd0-eb8f-45e7-ae92-8d06064b4be3, ghrun-5rmqn7spre.auto.internal:8062): creating call state
2025-10-27 12:38:18,227 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 76ffcdd0-eb8f-45e7-ae92-8d06064b4be3, ghrun-5rmqn7spre.auto.internal:8062): request = { session_id: "ydb://session/3?node_id=1&id=Y2QzMzA0MjAtYjdjZDEyZWMtZDVkZDhjNjktNzAxMWZkOWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/select/table43386_js` WHERE JSON_VALUE(vjs, \"$.vals[0].vs\") LIKE \"%x%\";" } stats_mode: STATS_MODE_NONE }
2025-10-27 12:38:18,229 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 76ffcdd0-eb8f-45e7-ae92-8d06064b4be3, ghrun-5rmqn7spre.auto.internal:8062): response = { <_MultiThreadedRendezvous object> }
2025-10-27 12:38:18,413 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2QzMzA0MjAtYjdjZDEyZWMtZDVkZDhjNjktNzAxMWZkOWU=
2025-10-27 12:38:18,413 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2QzMzA0MjAtYjdjZDEyZWMtZDVkZDhjNjktNzAxMWZkOWU=
2025-10-27 12:38:18,414 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b424f763-16d4-4031-8afa-e0edb7ee0fbd, ghrun-5rmqn7spre.auto.internal:8062): creating call state
2025-10-27 12:38:18,414 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b424f763-16d4-4031-8afa-e0edb7ee0fbd, ghrun-5rmqn7spre.auto.internal:8062): request = { session_id: "ydb://session/3?node_id=1&id=Y2QzMzA0MjAtYjdjZDEyZWMtZDVkZDhjNjktNzAxMWZkOWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT JSON_QUERY(vjs, \"$.vals\") AS json FROM `/Root/select/table43386_js` WHERE id = 11;" } stats_mode: STATS_MODE_NONE }
2025-10-27 12:38:18,417 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b424f763-16d4-4031-8afa-e0edb7ee0fbd, ghrun-5rmqn7spre.auto.internal:8062): response = { <_MultiThreadedRendezvous object> }
2025-10-27 12:38:18,526 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2QzMzA0MjAtYjdjZDEyZWMtZDVkZDhjNjktNzAxMWZkOWU=
2025-10-27 12:38:18,529 - INFO - ya.test - pytest_runtest_teardown: Test teardown
