2025-12-07 19:49:24,220 - INFO - ya.test.46679  - pytest_runtest_setup: ####################################################################################################
2025-12-07 19:49:24,220 - INFO - ya.test.46679  - pytest_runtest_setup: test_all_supported_compression[zstd_19_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 19]
2025-12-07 19:49:24,220 - INFO - ya.test.46679  - pytest_runtest_setup: ####################################################################################################
2025-12-07 19:49:24,221 - INFO - ya.test.46679  - pytest_runtest_setup: Test setup
2025-12-07 19:49:24,223 - INFO - ya.test.46679  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_19_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 19])
2025-12-07 19:49:24,224 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:49:24,224 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, 6a7c2765-05c0-478b-9b51-5083080bc08d, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:49:24,225 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, 6a7c2765-05c0-478b-9b51-5083080bc08d, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_19_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 19)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:49:24,226 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, 6a7c2765-05c0-478b-9b51-5083080bc08d, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:49:28,327 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:49:28,328 - INFO - __tests__.alter_compression.46679  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_19_compression created
2025-12-07 19:49:28,328 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:49:28,329 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, ffc8c735-cc7e-4ee8-895f-b56b5ab5fcdd, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:49:28,330 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, ffc8c735-cc7e-4ee8-895f-b56b5ab5fcdd, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_19_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:49:28,331 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, ffc8c735-cc7e-4ee8-895f-b56b5ab5fcdd, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:49:30,214 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:49:30,215 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:49:30,215 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, 38f64da4-859a-4493-8456-f282df2bcd50, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:49:30,217 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, 38f64da4-859a-4493-8456-f282df2bcd50, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 0;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_19_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:49:30,221 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, 38f64da4-859a-4493-8456-f282df2bcd50, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:49:36,828 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:49:36,829 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:49:36,829 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, f4f37694-73d8-4d09-ab4c-a2c9c3616719, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:49:36,830 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, f4f37694-73d8-4d09-ab4c-a2c9c3616719, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:49:36,832 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, f4f37694-73d8-4d09-ab4c-a2c9c3616719, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:49:38,268 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:49:38,268 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:49:38,269 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, ec5e7a6a-3ae6-4b0f-aea5-a50edcd190df, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:49:38,270 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, ec5e7a6a-3ae6-4b0f-aea5-a50edcd190df, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:49:38,273 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, ec5e7a6a-3ae6-4b0f-aea5-a50edcd190df, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:49:40,673 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:49:40,674 - INFO - __tests__.alter_compression.46679  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_19_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318528, 'BlobCount': 128}}
2025-12-07 19:49:40,674 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:49:40,675 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, 5db25289-bf6a-4796-93e6-415f3992d4bd, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:49:40,676 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, 5db25289-bf6a-4796-93e6-415f3992d4bd, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 100000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_19_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:49:40,678 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, 5db25289-bf6a-4796-93e6-415f3992d4bd, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:49:47,421 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:49:47,422 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:49:47,423 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, bad8f8f9-1ae7-4513-9778-3a555c038b1c, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:49:47,423 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, bad8f8f9-1ae7-4513-9778-3a555c038b1c, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:49:47,425 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, bad8f8f9-1ae7-4513-9778-3a555c038b1c, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:49:48,018 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:49:48,019 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:49:48,020 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, c3e0882a-3754-4300-ba0c-3b8343e43046, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:49:48,020 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, c3e0882a-3754-4300-ba0c-3b8343e43046, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:49:48,025 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, c3e0882a-3754-4300-ba0c-3b8343e43046, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:49:48,606 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:49:48,607 - INFO - __tests__.alter_compression.46679  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_19_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 637920, 'BlobCount': 256}}
2025-12-07 19:49:48,608 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:49:48,608 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, 2aae4d26-2f54-4390-a82c-699230433d5e, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:49:48,609 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, 2aae4d26-2f54-4390-a82c-699230433d5e, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 200000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_19_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:49:48,611 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, 2aae4d26-2f54-4390-a82c-699230433d5e, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:49:54,559 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:49:54,560 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:49:54,561 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, 164059fb-8896-40cc-bea3-a5f39239064d, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:49:54,562 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, 164059fb-8896-40cc-bea3-a5f39239064d, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:49:54,563 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, 164059fb-8896-40cc-bea3-a5f39239064d, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:49:55,107 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:49:55,108 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:49:55,109 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, 04295d3c-1ee0-47a8-9e35-07a4eefc305f, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:49:55,110 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, 04295d3c-1ee0-47a8-9e35-07a4eefc305f, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:49:55,111 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, 04295d3c-1ee0-47a8-9e35-07a4eefc305f, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:49:55,666 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:49:55,667 - INFO - __tests__.alter_compression.46679  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_19_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 956816, 'BlobCount': 384}}
2025-12-07 19:49:55,668 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:49:55,668 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, d7a54d65-ee25-4b11-88b6-121e2d9033c5, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:49:55,669 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, d7a54d65-ee25-4b11-88b6-121e2d9033c5, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 300000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_19_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:49:55,678 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, d7a54d65-ee25-4b11-88b6-121e2d9033c5, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:00,725 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:00,726 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:00,728 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, ebc37deb-f2d1-4928-86f1-5f53d8c1a865, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:50:00,729 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, ebc37deb-f2d1-4928-86f1-5f53d8c1a865, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:50:00,731 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, ebc37deb-f2d1-4928-86f1-5f53d8c1a865, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:01,070 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:01,071 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:01,072 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, 612c8e6f-80c6-46c6-bedd-d9738a1452a3, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:50:01,072 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, 612c8e6f-80c6-46c6-bedd-d9738a1452a3, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:50:01,074 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, 612c8e6f-80c6-46c6-bedd-d9738a1452a3, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:01,601 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:01,601 - INFO - __tests__.alter_compression.46679  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_19_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1276240, 'BlobCount': 512}}
2025-12-07 19:50:01,602 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:01,603 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, 940c5907-42ce-48e5-bde5-80c09c7a9489, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:50:01,603 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, 940c5907-42ce-48e5-bde5-80c09c7a9489, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 400000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_19_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:50:01,604 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, 940c5907-42ce-48e5-bde5-80c09c7a9489, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:06,948 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:06,949 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:06,949 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, 59e29745-1cb7-46d7-9d49-8c2b59b347d5, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:50:06,950 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, 59e29745-1cb7-46d7-9d49-8c2b59b347d5, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:50:06,952 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, 59e29745-1cb7-46d7-9d49-8c2b59b347d5, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:07,362 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:07,363 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:07,364 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, 54edfa26-8fb0-4976-9c99-18fbe5dbe6e4, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:50:07,365 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, 54edfa26-8fb0-4976-9c99-18fbe5dbe6e4, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:50:07,384 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, 54edfa26-8fb0-4976-9c99-18fbe5dbe6e4, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:08,422 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:08,423 - INFO - __tests__.alter_compression.46679  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_19_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1595136, 'BlobCount': 640}}
2025-12-07 19:50:08,424 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:08,424 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, afb12a73-eef9-4cd0-9280-ed889f0a3657, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:50:08,425 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, afb12a73-eef9-4cd0-9280-ed889f0a3657, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 500000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_19_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:50:08,426 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, afb12a73-eef9-4cd0-9280-ed889f0a3657, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:13,902 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:13,903 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:13,904 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, 0c7493f2-9035-41d6-88ed-ac196d7b7e65, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:50:13,905 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, 0c7493f2-9035-41d6-88ed-ac196d7b7e65, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:50:13,907 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, 0c7493f2-9035-41d6-88ed-ac196d7b7e65, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:14,230 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:14,231 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:14,232 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, 03eebbed-f59d-479b-99cf-e35c72e267b0, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:50:14,233 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, 03eebbed-f59d-479b-99cf-e35c72e267b0, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:50:14,234 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, 03eebbed-f59d-479b-99cf-e35c72e267b0, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:14,810 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:14,811 - INFO - __tests__.alter_compression.46679  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_19_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1914416, 'BlobCount': 768}}
2025-12-07 19:50:14,812 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:14,812 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, 7cbb0c42-4190-475e-9e1f-2127dd67528d, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:50:14,813 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, 7cbb0c42-4190-475e-9e1f-2127dd67528d, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 600000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_19_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:50:14,814 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, 7cbb0c42-4190-475e-9e1f-2127dd67528d, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:19,451 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:19,451 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:19,452 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, 85ce211e-ea90-4048-9e30-ec6928da5061, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:50:19,453 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, 85ce211e-ea90-4048-9e30-ec6928da5061, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:50:19,456 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, 85ce211e-ea90-4048-9e30-ec6928da5061, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:20,030 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:20,031 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:20,032 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, 70ff7693-959b-4079-b7a4-1ee1b9888d14, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:50:20,033 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, 70ff7693-959b-4079-b7a4-1ee1b9888d14, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:50:20,035 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, 70ff7693-959b-4079-b7a4-1ee1b9888d14, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:21,384 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:21,385 - INFO - __tests__.alter_compression.46679  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_19_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2233456, 'BlobCount': 896}}
2025-12-07 19:50:21,386 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:21,387 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, 2c78a52a-53e5-4e8f-9930-c82c50faec20, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:50:21,388 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, 2c78a52a-53e5-4e8f-9930-c82c50faec20, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 700000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_19_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:50:21,395 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, 2c78a52a-53e5-4e8f-9930-c82c50faec20, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:28,735 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:28,735 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:28,736 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, 26b533bb-47f2-453d-ac90-0680bd2eb349, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:50:28,737 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, 26b533bb-47f2-453d-ac90-0680bd2eb349, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:50:28,744 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, 26b533bb-47f2-453d-ac90-0680bd2eb349, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:29,143 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:29,144 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:29,145 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, 1eb896ef-b455-47c3-b26a-0fba27407634, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:50:29,146 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, 1eb896ef-b455-47c3-b26a-0fba27407634, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:50:29,148 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, 1eb896ef-b455-47c3-b26a-0fba27407634, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:30,218 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:30,218 - INFO - __tests__.alter_compression.46679  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_19_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2552960, 'BlobCount': 1024}}
2025-12-07 19:50:30,219 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:30,220 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, a552e246-309c-404e-bfeb-78e81fb9956a, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:50:30,221 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, a552e246-309c-404e-bfeb-78e81fb9956a, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 800000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_19_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:50:30,229 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, a552e246-309c-404e-bfeb-78e81fb9956a, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:37,822 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:37,823 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:37,824 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, c16a3dc5-9b31-463b-b4c1-d3feab442ab3, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:50:37,825 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, c16a3dc5-9b31-463b-b4c1-d3feab442ab3, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:50:37,830 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, c16a3dc5-9b31-463b-b4c1-d3feab442ab3, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:38,190 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:38,190 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:38,191 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, 086f09db-da98-4763-b24f-4682499b6cae, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:50:38,192 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, 086f09db-da98-4763-b24f-4682499b6cae, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:50:38,209 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, 086f09db-da98-4763-b24f-4682499b6cae, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:39,127 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:39,128 - INFO - __tests__.alter_compression.46679  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_19_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2871840, 'BlobCount': 1152}}
2025-12-07 19:50:39,128 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:39,129 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, 8a2c31c6-6093-4b32-ace7-c4b1f952d798, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:50:39,130 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, 8a2c31c6-6093-4b32-ace7-c4b1f952d798, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 900000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_19_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:50:39,131 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, 8a2c31c6-6093-4b32-ace7-c4b1f952d798, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:45,529 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:45,531 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:45,532 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, ec2053b3-db14-42b5-9458-4e428e530dbc, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:50:45,532 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, ec2053b3-db14-42b5-9458-4e428e530dbc, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:50:45,546 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, ec2053b3-db14-42b5-9458-4e428e530dbc, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:45,909 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:45,910 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:45,911 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, 916b1e69-4123-48de-8e84-d69e90ac9df5, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:50:45,912 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, 916b1e69-4123-48de-8e84-d69e90ac9df5, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:50:45,913 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, 916b1e69-4123-48de-8e84-d69e90ac9df5, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:47,622 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:47,623 - INFO - __tests__.alter_compression.46679  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_19_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3191408, 'BlobCount': 1280}}
2025-12-07 19:50:47,624 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:47,625 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, 67d379e6-f2c2-4124-8d9b-2d21e8f4cc84, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:50:47,625 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, 67d379e6-f2c2-4124-8d9b-2d21e8f4cc84, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_19_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:50:47,627 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, 67d379e6-f2c2-4124-8d9b-2d21e8f4cc84, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:50,546 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:50,547 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:50,548 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, 5b473a74-bd99-4e86-a8a5-ff2b1891dc47, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:50:50,549 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, 5b473a74-bd99-4e86-a8a5-ff2b1891dc47, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:50:50,550 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, 5b473a74-bd99-4e86-a8a5-ff2b1891dc47, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:51,113 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:51,113 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:51,114 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, 60b5b0ff-68a9-4613-a847-79e29f74ffc1, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:50:51,115 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, 60b5b0ff-68a9-4613-a847-79e29f74ffc1, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:50:51,120 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, 60b5b0ff-68a9-4613-a847-79e29f74ffc1, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:51,549 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:51,550 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:50:51,551 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, 91af7635-9e8a-42e4-a670-25b65f8283ee, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:50:51,552 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, 91af7635-9e8a-42e4-a670-25b65f8283ee, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:50:51,553 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, 91af7635-9e8a-42e4-a670-25b65f8283ee, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:57,449 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:51:07,564 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:51:07,565 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, a75ba33f-c999-44ed-a8ee-0cbfc5f2af27, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:51:07,566 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, a75ba33f-c999-44ed-a8ee-0cbfc5f2af27, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:51:07,567 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, a75ba33f-c999-44ed-a8ee-0cbfc5f2af27, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:51:10,402 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.46679  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-07 19:51:10,403 - DEBUG - ydb.connection.46679  - 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-12-07 19:51:10,416 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.46679  - context_resolve: Resolving endpoints for database /Root
2025-12-07 19:51:10,417 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ListEndpoints, 3fba5bd3-26a0-4af4-9978-269971193ad5, localhost:63443): creating call state
2025-12-07 19:51:10,417 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ListEndpoints, 3fba5bd3-26a0-4af4-9978-269971193ad5, localhost:63443): request = { database: "/Root" }
2025-12-07 19:51:10,431 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ListEndpoints, 3fba5bd3-26a0-4af4-9978-269971193ad5, localhost:63443): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-7gzmsyrbqy.auto.internal" port: 63443 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-12-07 19:51:10,432 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.46679  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-7gzmsyrbqy.auto.internal:63443, location 1, ssl: False>]>
2025-12-07 19:51:10,433 - DEBUG - ydb.connection.46679  - close: Closing channel for endpoint localhost:63443
2025-12-07 19:51:11,585 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:51:11,629 - INFO - root.46679  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_19_compression`, volumes `value` (8000000, 1595704)
2025-12-07 19:51:11,630 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:51:11,630 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, 1cc731cc-4b9c-48e8-a0e6-6b05770027e1, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:51:11,631 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, 1cc731cc-4b9c-48e8-a0e6-6b05770027e1, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:51:11,633 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, 1cc731cc-4b9c-48e8-a0e6-6b05770027e1, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:51:12,455 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:51:12,456 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:51:12,457 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, b81913f9-b3ae-465b-b8d9-6a3a8cf743eb, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:51:12,458 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, b81913f9-b3ae-465b-b8d9-6a3a8cf743eb, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:51:12,459 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, b81913f9-b3ae-465b-b8d9-6a3a8cf743eb, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:51:16,071 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:51:26,110 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:51:26,111 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, 4476294f-c153-47b7-a84f-093d665895c1, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:51:26,112 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, 4476294f-c153-47b7-a84f-093d665895c1, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:51:26,113 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, 4476294f-c153-47b7-a84f-093d665895c1, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:51:30,088 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:51:40,120 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:51:40,121 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, fbf0a67e-978e-48b9-819b-580d826c359d, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:51:40,121 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, fbf0a67e-978e-48b9-819b-580d826c359d, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:51:40,123 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, fbf0a67e-978e-48b9-819b-580d826c359d, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:51:42,554 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:51:52,574 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:51:52,575 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, 40b7c0d7-14ff-43e1-99a9-011fa27cdb44, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:51:52,576 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, 40b7c0d7-14ff-43e1-99a9-011fa27cdb44, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:51:52,579 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, 40b7c0d7-14ff-43e1-99a9-011fa27cdb44, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:51:53,833 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:52:03,839 - DEBUG - ydb.query.pool.46679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:52:03,840 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(ExecuteQuery, e2047c5e-e5f5-4b8c-b4ca-868bb2134d57, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:52:03,841 - DEBUG - ydb.connection.46679  - _log_request: RpcState(ExecuteQuery, e2047c5e-e5f5-4b8c-b4ca-868bb2134d57, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-07 19:52:03,843 - DEBUG - ydb.connection.46679  - _log_response: RpcState(ExecuteQuery, e2047c5e-e5f5-4b8c-b4ca-868bb2134d57, ghrun-7gzmsyrbqy.auto.internal:63443): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:52:05,264 - DEBUG - ydb.query.pool.46679  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=
2025-12-07 19:52:05,268 - INFO - root.46679  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_19_compression`, volumes `value` (8000000, 1465928)
2025-12-07 19:52:05,269 - INFO - root.46679  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_19_compression` 8026064 / 1465928: 5.475073809900623
2025-12-07 19:52:05,274 - INFO - ya.test.46679  - pytest_runtest_teardown: Test teardown
2025-12-07 19:52:05,275 - DEBUG - ydb.connection.46679  - _prepare_call: RpcState(DeleteSession, a425f09f-7f8c-453a-8467-9ecfd71d090d, ghrun-7gzmsyrbqy.auto.internal:63443): creating call state
2025-12-07 19:52:05,276 - DEBUG - ydb.connection.46679  - _log_request: RpcState(DeleteSession, a425f09f-7f8c-453a-8467-9ecfd71d090d, ghrun-7gzmsyrbqy.auto.internal:63443): request = { session_id: "ydb://session/3?node_id=1&id=MzhjOTliN2ItOWJkM2NhODAtZmI4MmJlY2YtYThlYzg4M2Q=" }
2025-12-07 19:52:05,287 - DEBUG - ydb.connection.46679  - _log_response: RpcState(DeleteSession, a425f09f-7f8c-453a-8467-9ecfd71d090d, ghrun-7gzmsyrbqy.auto.internal:63443): response = { status: SUCCESS }
2025-12-07 19:52:05,288 - DEBUG - ydb.query.pool.46679  - stop: All session were deleted.
2025-12-07 19:52:05,289 - DEBUG - ydb.topic.46679  - close: Close topic client
2025-12-07 19:52:05,289 - DEBUG - ydb.topic.46679  - close: Topic client was closed
2025-12-07 19:52:05,289 - DEBUG - ydb.connection.46679  - close: Closing channel for endpoint localhost:63443
2025-12-07 19:52:05,294 - DEBUG - ydb.connection.46679  - _rpc_error_handler: RpcState(AttachSession, ea77a952-e02b-4fab-9a8f-7360455ae4c1, ghrun-7gzmsyrbqy.auto.internal:63443): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.CANCELLED
	details = "Locally cancelled by application!"
	debug_error_string = "None"
>
2025-12-07 19:52:05,296 - DEBUG - ydb.connection.46679  - close: Closing channel for endpoint ghrun-7gzmsyrbqy.auto.internal:63443
2025-12-07 19:52:05,298 - INFO - ydb.pool.Discovery.46679  - run: Successfully terminated discovery process
2025-12-07 19:52:22,315 - INFO - ydb.tests.library.harness.kikimr_runner.46679  - stop: Stopped node localhost:63443/1
2025-12-07 19:52:22,323 - DEBUG - library.python.filelock.46679  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/15113
2025-12-07 19:52:22,323 - DEBUG - library.python.filelock.46679  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/15824
2025-12-07 19:52:22,324 - DEBUG - library.python.filelock.46679  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/29559
2025-12-07 19:52:22,324 - DEBUG - library.python.filelock.46679  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/63443
2025-12-07 19:52:22,324 - DEBUG - library.python.filelock.46679  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/2788
