2025-12-23 17:53:56,538 - INFO - ya.test.2335876  - pytest_runtest_setup: ####################################################################################################
2025-12-23 17:53:56,539 - INFO - ya.test.2335876  - pytest_runtest_setup: test_all_supported_compression[zstd_11_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 11]
2025-12-23 17:53:56,539 - INFO - ya.test.2335876  - pytest_runtest_setup: ####################################################################################################
2025-12-23 17:53:56,539 - INFO - ya.test.2335876  - pytest_runtest_setup: Test setup
2025-12-23 17:53:56,542 - INFO - ya.test.2335876  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_11_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 11])
2025-12-23 17:53:56,542 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:53:56,543 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, a737ea8e-3ba0-4818-9fc6-4ae2b1f4d18f, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:53:56,544 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, a737ea8e-3ba0-4818-9fc6-4ae2b1f4d18f, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_11_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 11)\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-23 17:53:56,545 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, a737ea8e-3ba0-4818-9fc6-4ae2b1f4d18f, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:02,881 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:02,882 - INFO - __tests__.alter_compression.2335876  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_11_compression created
2025-12-23 17:54:02,882 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:02,883 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, 4de2f9d3-17fd-4026-8ee1-5a126afa51d6, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:02,884 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, 4de2f9d3-17fd-4026-8ee1-5a126afa51d6, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_11_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:54:02,886 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, 4de2f9d3-17fd-4026-8ee1-5a126afa51d6, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:04,381 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:04,382 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:04,383 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, 79d5fcd4-bd55-4393-8a90-f127bc5c64cf, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:04,384 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, 79d5fcd4-bd55-4393-8a90-f127bc5c64cf, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:54:04,386 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, 79d5fcd4-bd55-4393-8a90-f127bc5c64cf, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:09,544 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:09,545 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:09,546 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, 5af64b64-68a3-43ad-bb8d-29877a7d7b79, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:09,547 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, 5af64b64-68a3-43ad-bb8d-29877a7d7b79, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:54:09,549 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, 5af64b64-68a3-43ad-bb8d-29877a7d7b79, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:11,117 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:11,118 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:11,119 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, 322e4bd5-deda-4085-8e8d-6e53dd77f8b0, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:11,130 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, 322e4bd5-deda-4085-8e8d-6e53dd77f8b0, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:54:11,132 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, 322e4bd5-deda-4085-8e8d-6e53dd77f8b0, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:14,798 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:14,799 - INFO - __tests__.alter_compression.2335876  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_11_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 375776, 'BlobCount': 128}}
2025-12-23 17:54:14,800 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:14,806 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, ae7ffbea-0fa7-47b7-b266-0bccd09ce2cb, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:14,807 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, ae7ffbea-0fa7-47b7-b266-0bccd09ce2cb, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:54:14,809 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, ae7ffbea-0fa7-47b7-b266-0bccd09ce2cb, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:18,069 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:18,069 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:18,070 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, b15cd44c-66aa-4ea9-9651-e9747d20296a, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:18,071 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, b15cd44c-66aa-4ea9-9651-e9747d20296a, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:54:18,073 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, b15cd44c-66aa-4ea9-9651-e9747d20296a, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:18,713 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:18,714 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:18,715 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, 44805bd3-e75b-42c0-8dc4-faabc861a84c, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:18,716 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, 44805bd3-e75b-42c0-8dc4-faabc861a84c, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:54:18,718 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, 44805bd3-e75b-42c0-8dc4-faabc861a84c, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:19,410 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:19,410 - INFO - __tests__.alter_compression.2335876  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_11_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 753008, 'BlobCount': 256}}
2025-12-23 17:54:19,411 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:19,411 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, 7e8e8d24-30f9-4643-846b-4c313c17838b, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:19,412 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, 7e8e8d24-30f9-4643-846b-4c313c17838b, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:54:19,413 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, 7e8e8d24-30f9-4643-846b-4c313c17838b, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:22,327 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:22,328 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:22,329 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, 3edf1720-28a9-4a45-940e-b7cadf92a9ad, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:22,330 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, 3edf1720-28a9-4a45-940e-b7cadf92a9ad, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:54:22,334 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, 3edf1720-28a9-4a45-940e-b7cadf92a9ad, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:22,950 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:22,951 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:22,952 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, 119ebf4f-eac2-4523-b799-292a7b2a1908, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:22,953 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, 119ebf4f-eac2-4523-b799-292a7b2a1908, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:54:22,956 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, 119ebf4f-eac2-4523-b799-292a7b2a1908, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:23,846 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:23,847 - INFO - __tests__.alter_compression.2335876  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_11_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 1129888, 'BlobCount': 384}}
2025-12-23 17:54:23,847 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:23,848 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, 2dda2178-b7b2-4eea-979a-38775db2c903, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:23,849 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, 2dda2178-b7b2-4eea-979a-38775db2c903, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:54:23,853 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, 2dda2178-b7b2-4eea-979a-38775db2c903, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:27,504 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:27,505 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:27,506 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, cca460e3-17a1-4081-a001-adec4679d964, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:27,507 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, cca460e3-17a1-4081-a001-adec4679d964, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:54:27,513 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, cca460e3-17a1-4081-a001-adec4679d964, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:28,203 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:28,204 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:28,205 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, 7b84c46a-4ddd-44e9-b152-1f23f0ddf228, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:28,206 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, 7b84c46a-4ddd-44e9-b152-1f23f0ddf228, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:54:28,211 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, 7b84c46a-4ddd-44e9-b152-1f23f0ddf228, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:29,069 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:29,069 - INFO - __tests__.alter_compression.2335876  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_11_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1507072, 'BlobCount': 512}}
2025-12-23 17:54:29,070 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:29,071 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, bc85dcff-81e5-47e1-b028-83d671c72ddf, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:29,072 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, bc85dcff-81e5-47e1-b028-83d671c72ddf, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:54:29,078 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, bc85dcff-81e5-47e1-b028-83d671c72ddf, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:33,050 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:33,051 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:33,051 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, 7ae2e5e0-9f93-454f-8c40-045402fa60b8, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:33,052 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, 7ae2e5e0-9f93-454f-8c40-045402fa60b8, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:54:33,054 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, 7ae2e5e0-9f93-454f-8c40-045402fa60b8, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:33,621 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:33,622 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:33,623 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, 5e5a6ca6-b759-4b72-8087-66fc0c378700, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:33,624 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, 5e5a6ca6-b759-4b72-8087-66fc0c378700, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:54:33,627 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, 5e5a6ca6-b759-4b72-8087-66fc0c378700, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:34,473 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:34,474 - INFO - __tests__.alter_compression.2335876  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_11_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1883936, 'BlobCount': 640}}
2025-12-23 17:54:34,474 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:34,475 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, 5bcca3bc-632d-4512-bb5e-9672b6c0071f, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:34,476 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, 5bcca3bc-632d-4512-bb5e-9672b6c0071f, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:54:34,478 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, 5bcca3bc-632d-4512-bb5e-9672b6c0071f, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:38,486 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:38,487 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:38,488 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, d4bb1a7b-d5c1-4df0-b40a-085a763bb393, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:38,489 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, d4bb1a7b-d5c1-4df0-b40a-085a763bb393, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:54:38,491 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, d4bb1a7b-d5c1-4df0-b40a-085a763bb393, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:39,061 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:39,085 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:39,086 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, 675e32f8-1df6-41bf-a98a-950e93001736, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:39,087 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, 675e32f8-1df6-41bf-a98a-950e93001736, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:54:39,064 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335876  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-23 17:54:39,096 - DEBUG - ydb.connection.2335876  - 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', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 17:54:39,095 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, 675e32f8-1df6-41bf-a98a-950e93001736, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:39,119 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335876  - context_resolve: Resolving endpoints for database /Root
2025-12-23 17:54:39,125 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ListEndpoints, f2112d7e-8b4c-4972-bc6c-2a891d977636, localhost:15261): creating call state
2025-12-23 17:54:39,126 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ListEndpoints, f2112d7e-8b4c-4972-bc6c-2a891d977636, localhost:15261): request = { database: "/Root" }
2025-12-23 17:54:39,149 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ListEndpoints, f2112d7e-8b4c-4972-bc6c-2a891d977636, localhost:15261): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-yh5r7pxf7y.auto.internal" port: 15261 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-23 17:54:39,150 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335876  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-yh5r7pxf7y.auto.internal:15261, location 1, ssl: False>]>
2025-12-23 17:54:39,150 - DEBUG - ydb.connection.2335876  - close: Closing channel for endpoint localhost:15261
2025-12-23 17:54:39,682 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:39,683 - INFO - __tests__.alter_compression.2335876  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_11_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 2261136, 'BlobCount': 768}}
2025-12-23 17:54:39,684 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:39,684 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, d3cd89e6-cd7d-4392-a403-3d8b66ad35d2, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:39,695 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, d3cd89e6-cd7d-4392-a403-3d8b66ad35d2, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:54:39,697 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, d3cd89e6-cd7d-4392-a403-3d8b66ad35d2, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:43,469 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:43,470 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:43,471 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, 317a3f50-1c52-491c-9d2b-f2df8481baa2, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:43,472 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, 317a3f50-1c52-491c-9d2b-f2df8481baa2, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:54:43,474 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, 317a3f50-1c52-491c-9d2b-f2df8481baa2, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:43,934 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:43,935 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:43,936 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, 82db8686-9f2c-4f3c-9f82-47513239be75, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:43,937 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, 82db8686-9f2c-4f3c-9f82-47513239be75, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:54:43,940 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, 82db8686-9f2c-4f3c-9f82-47513239be75, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:45,046 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:45,047 - INFO - __tests__.alter_compression.2335876  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_11_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2638112, 'BlobCount': 896}}
2025-12-23 17:54:45,047 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:45,048 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, 640798e7-1b7a-4ecd-a08c-682f2568a02b, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:45,050 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, 640798e7-1b7a-4ecd-a08c-682f2568a02b, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:54:45,054 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, 640798e7-1b7a-4ecd-a08c-682f2568a02b, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:48,746 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:48,746 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:48,747 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, 646da262-bdd8-45af-970e-dbc9cdb1567b, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:48,748 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, 646da262-bdd8-45af-970e-dbc9cdb1567b, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:54:48,750 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, 646da262-bdd8-45af-970e-dbc9cdb1567b, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:49,222 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:49,223 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:49,224 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, 556e88d7-9b29-4f42-bbd7-dd50b9cf5288, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:49,225 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, 556e88d7-9b29-4f42-bbd7-dd50b9cf5288, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:54:49,227 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, 556e88d7-9b29-4f42-bbd7-dd50b9cf5288, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:49,991 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:49,992 - INFO - __tests__.alter_compression.2335876  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_11_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 3015280, 'BlobCount': 1024}}
2025-12-23 17:54:49,992 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:49,993 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, 0e7c9577-fff4-4615-96e9-e834a96b1039, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:49,996 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, 0e7c9577-fff4-4615-96e9-e834a96b1039, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:54:49,998 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, 0e7c9577-fff4-4615-96e9-e834a96b1039, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:53,867 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:53,868 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:53,869 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, b3e4cc02-bb58-427e-9d6c-2f29387bf2dc, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:53,870 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, b3e4cc02-bb58-427e-9d6c-2f29387bf2dc, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:54:53,872 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, b3e4cc02-bb58-427e-9d6c-2f29387bf2dc, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:54,261 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:54,262 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:54,263 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, f8f0e779-7591-440b-9d79-6d995ee0c598, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:54,264 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, f8f0e779-7591-440b-9d79-6d995ee0c598, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:54:54,266 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, f8f0e779-7591-440b-9d79-6d995ee0c598, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:55,669 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:55,670 - INFO - __tests__.alter_compression.2335876  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_11_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 3392288, 'BlobCount': 1152}}
2025-12-23 17:54:55,670 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:55,671 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, 0eec9f50-d71a-4740-bd21-20975654f53f, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:55,672 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, 0eec9f50-d71a-4740-bd21-20975654f53f, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:54:55,675 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, 0eec9f50-d71a-4740-bd21-20975654f53f, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:59,970 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:59,971 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:54:59,972 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, f855c50c-bed0-4322-a9b3-556f36e89f0e, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:54:59,973 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, f855c50c-bed0-4322-a9b3-556f36e89f0e, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:54:59,979 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, f855c50c-bed0-4322-a9b3-556f36e89f0e, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:55:00,346 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:55:00,347 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:55:00,348 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, 763a3f66-c64e-402c-b2dc-13ddf5e955f9, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:55:00,349 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, 763a3f66-c64e-402c-b2dc-13ddf5e955f9, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:55:00,351 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, 763a3f66-c64e-402c-b2dc-13ddf5e955f9, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:55:01,092 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:55:01,093 - INFO - __tests__.alter_compression.2335876  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_11_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3769600, 'BlobCount': 1280}}
2025-12-23 17:55:01,094 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:55:01,094 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, 84c2779c-76d2-4469-8467-3ac8f5997d0b, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:55:01,095 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, 84c2779c-76d2-4469-8467-3ac8f5997d0b, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_11_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:55:01,097 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, 84c2779c-76d2-4469-8467-3ac8f5997d0b, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:55:02,917 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:55:02,918 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:55:02,918 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, b1f4e2e7-795a-4b60-9d3b-13740c74d71a, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:55:02,919 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, b1f4e2e7-795a-4b60-9d3b-13740c74d71a, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:55:02,931 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, b1f4e2e7-795a-4b60-9d3b-13740c74d71a, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:55:03,333 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:55:03,334 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:55:03,334 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, f4602607-701f-4a1b-bf68-1ff7672ea230, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:55:03,335 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, f4602607-701f-4a1b-bf68-1ff7672ea230, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:55:03,337 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, f4602607-701f-4a1b-bf68-1ff7672ea230, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:55:03,645 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:55:03,646 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:55:03,647 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, f2e29bf8-d1dd-472a-aef3-278592ae01ae, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:55:03,648 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, f2e29bf8-d1dd-472a-aef3-278592ae01ae, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_11_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-23 17:55:03,649 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, f2e29bf8-d1dd-472a-aef3-278592ae01ae, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:55:08,240 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:55:18,275 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:55:18,276 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, 8fb8f77e-71d9-42e4-aa44-a8df3c87a962, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:55:18,277 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, 8fb8f77e-71d9-42e4-aa44-a8df3c87a962, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_11_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-23 17:55:18,278 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, 8fb8f77e-71d9-42e4-aa44-a8df3c87a962, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:55:19,755 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:55:29,761 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:55:29,762 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, b1b6412a-3fe9-469c-bc7e-5fc0d0e25ad9, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:55:29,763 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, b1b6412a-3fe9-469c-bc7e-5fc0d0e25ad9, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_11_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-23 17:55:29,766 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, b1b6412a-3fe9-469c-bc7e-5fc0d0e25ad9, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:55:30,675 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:55:40,681 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:55:40,682 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, f4b31de7-62f9-4a82-9966-fb39aa660fa5, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:55:40,683 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, f4b31de7-62f9-4a82-9966-fb39aa660fa5, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_11_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-23 17:55:40,685 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, f4b31de7-62f9-4a82-9966-fb39aa660fa5, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:55:41,566 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:55:41,571 - INFO - root.2335876  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_11_compression`, volumes `value` (8000000, 1465344)
2025-12-23 17:55:41,571 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:55:41,572 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, 5d112f4c-f493-4db9-ae8e-633d6a8e29ea, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:55:41,573 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, 5d112f4c-f493-4db9-ae8e-633d6a8e29ea, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" 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_11_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-23 17:55:41,575 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, 5d112f4c-f493-4db9-ae8e-633d6a8e29ea, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:55:41,905 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:55:41,906 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:55:41,906 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, 7a5f7ead-7d1e-464a-9a3b-ce923aa4ff03, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:55:41,907 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, 7a5f7ead-7d1e-464a-9a3b-ce923aa4ff03, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_11_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-23 17:55:41,909 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, 7a5f7ead-7d1e-464a-9a3b-ce923aa4ff03, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:55:42,874 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:55:52,880 - DEBUG - ydb.query.pool.2335876  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:55:52,881 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(ExecuteQuery, 963761cf-71ca-424d-9ac8-7a7e1e8fe050, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:55:52,882 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(ExecuteQuery, 963761cf-71ca-424d-9ac8-7a7e1e8fe050, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_11_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-23 17:55:52,883 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(ExecuteQuery, 963761cf-71ca-424d-9ac8-7a7e1e8fe050, ghrun-yh5r7pxf7y.auto.internal:15261): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:55:53,825 - DEBUG - ydb.query.pool.2335876  - release: Session returned to queue: ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=
2025-12-23 17:55:53,830 - INFO - root.2335876  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_11_compression`, volumes `value` (8000000, 1465344)
2025-12-23 17:55:53,830 - INFO - root.2335876  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_11_compression` 8092160 / 1465344: 5.522361984626135
2025-12-23 17:55:53,836 - INFO - ya.test.2335876  - pytest_runtest_teardown: Test teardown
2025-12-23 17:55:53,838 - DEBUG - ydb.connection.2335876  - _prepare_call: RpcState(DeleteSession, c80faf6e-3115-47c1-b108-8c6e3b784844, ghrun-yh5r7pxf7y.auto.internal:15261): creating call state
2025-12-23 17:55:53,838 - DEBUG - ydb.connection.2335876  - _log_request: RpcState(DeleteSession, c80faf6e-3115-47c1-b108-8c6e3b784844, ghrun-yh5r7pxf7y.auto.internal:15261): request = { session_id: "ydb://session/3?node_id=1&id=OTNhYTdlMzItZTQwM2ZmM2UtNTI4YmZiN2UtYzVhNzFiNDE=" }
2025-12-23 17:55:53,850 - DEBUG - ydb.connection.2335876  - _log_response: RpcState(DeleteSession, c80faf6e-3115-47c1-b108-8c6e3b784844, ghrun-yh5r7pxf7y.auto.internal:15261): response = { status: SUCCESS }
2025-12-23 17:55:53,851 - DEBUG - ydb.query.pool.2335876  - stop: All session were deleted.
2025-12-23 17:55:53,851 - DEBUG - ydb.topic.2335876  - close: Close topic client
2025-12-23 17:55:53,851 - DEBUG - ydb.topic.2335876  - close: Topic client was closed
2025-12-23 17:55:53,852 - DEBUG - ydb.connection.2335876  - close: Closing channel for endpoint localhost:15261
2025-12-23 17:55:53,856 - DEBUG - ydb.connection.2335876  - close: Closing channel for endpoint ghrun-yh5r7pxf7y.auto.internal:15261
2025-12-23 17:55:53,858 - INFO - ydb.pool.Discovery.2335876  - run: Successfully terminated discovery process
2025-12-23 17:56:10,882 - INFO - ydb.tests.library.harness.kikimr_runner.2335876  - stop: Stopped node localhost:15261/1
2025-12-23 17:56:10,892 - DEBUG - library.python.filelock.2335876  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/31364
2025-12-23 17:56:10,893 - DEBUG - library.python.filelock.2335876  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/14463
2025-12-23 17:56:10,893 - DEBUG - library.python.filelock.2335876  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/20508
2025-12-23 17:56:10,894 - DEBUG - library.python.filelock.2335876  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/15261
2025-12-23 17:56:10,894 - DEBUG - library.python.filelock.2335876  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/32704
