2025-12-07 19:49:57,663 - INFO - ya.test.35415  - pytest_runtest_setup: ####################################################################################################
2025-12-07 19:49:57,664 - INFO - ya.test.35415  - pytest_runtest_setup: test_all_supported_compression[zstd_11_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 11]
2025-12-07 19:49:57,664 - INFO - ya.test.35415  - pytest_runtest_setup: ####################################################################################################
2025-12-07 19:49:57,664 - INFO - ya.test.35415  - pytest_runtest_setup: Test setup
2025-12-07 19:49:57,666 - INFO - ya.test.35415  - 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-07 19:49:57,667 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:49:57,668 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, 311430e2-8f23-41dc-9b29-5f274e8bbaf6, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:49:57,669 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, 311430e2-8f23-41dc-9b29-5f274e8bbaf6, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:49:57,676 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, 311430e2-8f23-41dc-9b29-5f274e8bbaf6, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:01,082 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:01,083 - INFO - __tests__.alter_compression.35415  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_11_compression created
2025-12-07 19:50:01,083 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:01,084 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, 1c2be0a0-9249-4795-bd08-25245d4b380c, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:01,085 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, 1c2be0a0-9249-4795-bd08-25245d4b380c, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:01,087 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, 1c2be0a0-9249-4795-bd08-25245d4b380c, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:02,535 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:02,536 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:02,537 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, 72e2a53c-41b7-4745-85ba-e3ee503f4873, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:02,538 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, 72e2a53c-41b7-4745-85ba-e3ee503f4873, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:02,540 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, 72e2a53c-41b7-4745-85ba-e3ee503f4873, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:05,567 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:05,568 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:05,569 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, dd7fa7e8-36ea-4137-b3b1-fbbd84537949, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:05,569 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, dd7fa7e8-36ea-4137-b3b1-fbbd84537949, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:05,571 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, dd7fa7e8-36ea-4137-b3b1-fbbd84537949, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:06,751 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:06,752 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:06,753 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, 24530d08-31a3-457f-ba00-a362c22b23de, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:06,753 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, 24530d08-31a3-457f-ba00-a362c22b23de, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:06,759 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, 24530d08-31a3-457f-ba00-a362c22b23de, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:09,075 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:09,075 - INFO - __tests__.alter_compression.35415  - 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-07 19:50:09,076 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:09,077 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, 2737ef08-6693-47c6-90f5-98cf747ed0ea, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:09,078 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, 2737ef08-6693-47c6-90f5-98cf747ed0ea, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:09,079 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, 2737ef08-6693-47c6-90f5-98cf747ed0ea, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:11,821 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:11,822 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:11,822 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, 72fdbc3e-f515-4ce6-a333-0499af99349e, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:11,823 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, 72fdbc3e-f515-4ce6-a333-0499af99349e, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:11,824 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, 72fdbc3e-f515-4ce6-a333-0499af99349e, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:12,126 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:12,127 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:12,128 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, 9df7c17f-9c33-42d0-ae1c-f2a1bbe820eb, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:12,129 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, 9df7c17f-9c33-42d0-ae1c-f2a1bbe820eb, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:12,132 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, 9df7c17f-9c33-42d0-ae1c-f2a1bbe820eb, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:12,792 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:12,793 - INFO - __tests__.alter_compression.35415  - 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-07 19:50:12,793 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:12,794 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, 60e20a7b-d395-4b52-8f00-287c7e4d1a81, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:12,795 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, 60e20a7b-d395-4b52-8f00-287c7e4d1a81, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:12,806 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, 60e20a7b-d395-4b52-8f00-287c7e4d1a81, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:15,792 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:15,793 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:15,793 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, 599b1e83-736f-491b-a0d0-3e8b91220e0e, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:15,794 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, 599b1e83-736f-491b-a0d0-3e8b91220e0e, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:15,796 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, 599b1e83-736f-491b-a0d0-3e8b91220e0e, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:16,311 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:16,312 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:16,312 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, edd1110f-aab6-48b8-a203-9bdacbf9af7b, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:16,313 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, edd1110f-aab6-48b8-a203-9bdacbf9af7b, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:16,322 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, edd1110f-aab6-48b8-a203-9bdacbf9af7b, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:16,887 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:16,888 - INFO - __tests__.alter_compression.35415  - 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-07 19:50:16,889 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:16,889 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, b41276d7-aef6-4401-8dee-3d7e6bf778d7, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:16,890 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, b41276d7-aef6-4401-8dee-3d7e6bf778d7, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:16,892 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, b41276d7-aef6-4401-8dee-3d7e6bf778d7, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:19,267 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:19,268 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:19,268 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, fa33327a-505e-499c-9687-a741cd65f851, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:19,269 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, fa33327a-505e-499c-9687-a741cd65f851, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:19,276 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, fa33327a-505e-499c-9687-a741cd65f851, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:19,854 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:19,855 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:19,856 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, 3a60d584-a7ae-4318-902c-05a2f060fea6, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:19,857 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, 3a60d584-a7ae-4318-902c-05a2f060fea6, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:19,859 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, 3a60d584-a7ae-4318-902c-05a2f060fea6, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:20,602 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:20,603 - INFO - __tests__.alter_compression.35415  - 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-07 19:50:20,604 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:20,604 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, b4b6c797-c230-4f3a-82ac-a4c189d494db, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:20,605 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, b4b6c797-c230-4f3a-82ac-a4c189d494db, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:20,611 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, b4b6c797-c230-4f3a-82ac-a4c189d494db, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:23,274 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:23,275 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:23,276 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, 02aecad2-f811-4b70-b354-b391f7c7c669, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:23,277 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, 02aecad2-f811-4b70-b354-b391f7c7c669, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:23,279 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, 02aecad2-f811-4b70-b354-b391f7c7c669, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:23,687 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:23,688 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:23,689 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, ec45405d-9030-4e8b-a551-84693942f51a, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:23,689 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, ec45405d-9030-4e8b-a551-84693942f51a, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:23,693 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, ec45405d-9030-4e8b-a551-84693942f51a, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:24,325 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:24,326 - INFO - __tests__.alter_compression.35415  - 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-07 19:50:24,326 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:24,327 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, e13e226f-26b6-478a-b68a-65babecf6b73, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:24,328 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, e13e226f-26b6-478a-b68a-65babecf6b73, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:24,334 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, e13e226f-26b6-478a-b68a-65babecf6b73, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:27,356 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.35415  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-07 19:50:27,356 - DEBUG - ydb.connection.35415  - 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:50:27,360 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:27,361 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:27,361 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, 8b6425a1-3d42-4ac0-afdc-7f37c296790d, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:27,362 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, 8b6425a1-3d42-4ac0-afdc-7f37c296790d, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:27,364 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, 8b6425a1-3d42-4ac0-afdc-7f37c296790d, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:27,399 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.35415  - context_resolve: Resolving endpoints for database /Root
2025-12-07 19:50:27,400 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ListEndpoints, 43abaaa6-db1d-4263-8d18-53ee4a8119c1, localhost:15411): creating call state
2025-12-07 19:50:27,400 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ListEndpoints, 43abaaa6-db1d-4263-8d18-53ee4a8119c1, localhost:15411): request = { database: "/Root" }
2025-12-07 19:50:27,419 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ListEndpoints, 43abaaa6-db1d-4263-8d18-53ee4a8119c1, localhost:15411): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-7gzmsyrbqy.auto.internal" port: 15411 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:50:27,421 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.35415  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-7gzmsyrbqy.auto.internal:15411, location 1, ssl: False>]>
2025-12-07 19:50:27,421 - DEBUG - ydb.connection.35415  - close: Closing channel for endpoint localhost:15411
2025-12-07 19:50:27,818 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:27,819 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:27,820 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, b9c30d80-4c41-4f72-b35a-f9550f354626, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:27,821 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, b9c30d80-4c41-4f72-b35a-f9550f354626, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:27,827 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, b9c30d80-4c41-4f72-b35a-f9550f354626, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:28,791 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:28,792 - INFO - __tests__.alter_compression.35415  - 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-07 19:50:28,793 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:28,793 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, d4378feb-5e2f-4147-8e6b-4122ca004c07, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:28,794 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, d4378feb-5e2f-4147-8e6b-4122ca004c07, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:28,796 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, d4378feb-5e2f-4147-8e6b-4122ca004c07, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:32,111 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:32,111 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:32,112 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, 52fd617c-3565-4ec3-9335-b43362fac95f, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:32,113 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, 52fd617c-3565-4ec3-9335-b43362fac95f, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:32,119 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, 52fd617c-3565-4ec3-9335-b43362fac95f, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:32,718 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:32,719 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:32,720 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, 0c883b42-cdfb-4d93-8938-27074c66e8b7, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:32,721 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, 0c883b42-cdfb-4d93-8938-27074c66e8b7, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:32,725 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, 0c883b42-cdfb-4d93-8938-27074c66e8b7, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:33,502 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:33,503 - INFO - __tests__.alter_compression.35415  - 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-07 19:50:33,503 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:33,504 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, 5ca78da6-bfd3-4d45-af0c-4155b4afc737, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:33,505 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, 5ca78da6-bfd3-4d45-af0c-4155b4afc737, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:33,508 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, 5ca78da6-bfd3-4d45-af0c-4155b4afc737, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:36,972 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:36,973 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:36,974 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, e82f8098-bb96-4282-ab58-c279c3bf4e04, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:36,975 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, e82f8098-bb96-4282-ab58-c279c3bf4e04, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:36,976 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, e82f8098-bb96-4282-ab58-c279c3bf4e04, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:37,632 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:37,633 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:37,634 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, df06f02c-beaa-4c90-a1bf-3de2eaf1cc8f, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:37,635 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, df06f02c-beaa-4c90-a1bf-3de2eaf1cc8f, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:37,636 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, df06f02c-beaa-4c90-a1bf-3de2eaf1cc8f, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:39,558 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:39,559 - INFO - __tests__.alter_compression.35415  - 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-07 19:50:39,560 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:39,560 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, de0c61d5-9ff9-4db8-9b9a-02c13565757b, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:39,561 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, de0c61d5-9ff9-4db8-9b9a-02c13565757b, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:39,575 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, de0c61d5-9ff9-4db8-9b9a-02c13565757b, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:43,629 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:43,630 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:43,631 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, 10e0d667-b244-4f47-9ea8-44f6c2e03a81, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:43,632 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, 10e0d667-b244-4f47-9ea8-44f6c2e03a81, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:43,633 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, 10e0d667-b244-4f47-9ea8-44f6c2e03a81, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:44,666 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:44,667 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:44,668 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, 09a48979-8e9f-4d92-b2d9-87f00fb266ff, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:44,669 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, 09a48979-8e9f-4d92-b2d9-87f00fb266ff, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:44,670 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, 09a48979-8e9f-4d92-b2d9-87f00fb266ff, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:46,237 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:46,238 - INFO - __tests__.alter_compression.35415  - 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-07 19:50:46,238 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:46,239 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, 7fff3fc1-b89e-449f-9f8a-c3f0b73f1d48, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:46,240 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, 7fff3fc1-b89e-449f-9f8a-c3f0b73f1d48, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:46,241 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, 7fff3fc1-b89e-449f-9f8a-c3f0b73f1d48, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:51,578 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:51,579 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:51,579 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, 19c33324-6747-40e2-9db2-8d7013c4a7e5, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:51,580 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, 19c33324-6747-40e2-9db2-8d7013c4a7e5, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:51,582 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, 19c33324-6747-40e2-9db2-8d7013c4a7e5, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:51,930 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:51,931 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:51,931 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, 7e4425af-9922-42bc-85bd-3b6b8035fa91, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:51,932 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, 7e4425af-9922-42bc-85bd-3b6b8035fa91, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:51,935 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, 7e4425af-9922-42bc-85bd-3b6b8035fa91, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:52,996 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:52,996 - INFO - __tests__.alter_compression.35415  - 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-07 19:50:52,997 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:52,998 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, ab4881f5-adf0-4c34-bac0-ccf2f5569939, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:52,999 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, ab4881f5-adf0-4c34-bac0-ccf2f5569939, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:53,000 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, ab4881f5-adf0-4c34-bac0-ccf2f5569939, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:55,291 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:55,292 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:55,293 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, 897d6fa4-d09c-40b5-96d6-d587b5c7b6f7, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:55,294 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, 897d6fa4-d09c-40b5-96d6-d587b5c7b6f7, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:55,297 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, 897d6fa4-d09c-40b5-96d6-d587b5c7b6f7, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:55,938 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:55,939 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:55,940 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, ae918ab3-86e3-4e6a-8cf3-db801878cf70, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:55,941 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, ae918ab3-86e3-4e6a-8cf3-db801878cf70, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:55,942 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, ae918ab3-86e3-4e6a-8cf3-db801878cf70, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:50:56,676 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:56,686 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:50:56,687 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, 6a7b843f-4a44-4def-887b-83643fea5bd4, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:50:56,688 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, 6a7b843f-4a44-4def-887b-83643fea5bd4, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:50:56,698 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, 6a7b843f-4a44-4def-887b-83643fea5bd4, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:51:04,309 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:51:14,340 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:51:14,341 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, 8801b587-ccf9-4180-b7eb-739051d38fe6, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:51:14,342 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, 8801b587-ccf9-4180-b7eb-739051d38fe6, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:51:14,343 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, 8801b587-ccf9-4180-b7eb-739051d38fe6, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:51:16,868 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:51:26,886 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:51:26,887 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, bdc9c844-09aa-44cd-a447-485038511037, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:51:26,888 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, bdc9c844-09aa-44cd-a447-485038511037, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:51:26,889 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, bdc9c844-09aa-44cd-a447-485038511037, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:51:27,739 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:51:37,745 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:51:37,746 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, f2b65a5c-1355-4380-b936-074c30a357c0, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:51:37,747 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, f2b65a5c-1355-4380-b936-074c30a357c0, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:51:37,749 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, f2b65a5c-1355-4380-b936-074c30a357c0, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:51:38,756 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:51:38,760 - INFO - root.35415  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_11_compression`, volumes `value` (8000000, 1465344)
2025-12-07 19:51:38,761 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:51:38,762 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, 04df7c81-ab60-4a14-bbff-4e347a48f8c2, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:51:38,762 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, 04df7c81-ab60-4a14-bbff-4e347a48f8c2, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:51:38,764 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, 04df7c81-ab60-4a14-bbff-4e347a48f8c2, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:51:38,992 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:51:38,993 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:51:38,993 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, 54b08b66-567c-4d30-89c3-b6e69792cb91, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:51:38,994 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, 54b08b66-567c-4d30-89c3-b6e69792cb91, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:51:38,995 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, 54b08b66-567c-4d30-89c3-b6e69792cb91, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:51:39,679 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:51:49,690 - DEBUG - ydb.query.pool.35415  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:51:49,691 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(ExecuteQuery, e0991dba-ef31-4635-b879-747442ef08e3, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:51:49,692 - DEBUG - ydb.connection.35415  - _log_request: RpcState(ExecuteQuery, e0991dba-ef31-4635-b879-747442ef08e3, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" 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-07 19:51:49,693 - DEBUG - ydb.connection.35415  - _log_response: RpcState(ExecuteQuery, e0991dba-ef31-4635-b879-747442ef08e3, ghrun-7gzmsyrbqy.auto.internal:15411): response = { <_MultiThreadedRendezvous object> }
2025-12-07 19:51:50,292 - DEBUG - ydb.query.pool.35415  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi
2025-12-07 19:51:50,295 - INFO - root.35415  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_11_compression`, volumes `value` (8000000, 1465344)
2025-12-07 19:51:50,295 - INFO - root.35415  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_11_compression` 8009216 / 1465344: 5.46575821104123
2025-12-07 19:51:50,311 - INFO - ya.test.35415  - pytest_runtest_teardown: Test teardown
2025-12-07 19:51:50,312 - DEBUG - ydb.connection.35415  - _prepare_call: RpcState(DeleteSession, bf768727-6a55-4cfa-94f2-e77c7994f950, ghrun-7gzmsyrbqy.auto.internal:15411): creating call state
2025-12-07 19:51:50,313 - DEBUG - ydb.connection.35415  - _log_request: RpcState(DeleteSession, bf768727-6a55-4cfa-94f2-e77c7994f950, ghrun-7gzmsyrbqy.auto.internal:15411): request = { session_id: "ydb://session/3?node_id=1&id=NmE0YzUzZC0xYzFhZGYzLWVjZGQ5NTZmLWU5MjMxMGFi" }
2025-12-07 19:51:50,315 - DEBUG - ydb.connection.35415  - _log_response: RpcState(DeleteSession, bf768727-6a55-4cfa-94f2-e77c7994f950, ghrun-7gzmsyrbqy.auto.internal:15411): response = { status: SUCCESS }
2025-12-07 19:51:50,316 - DEBUG - ydb.query.pool.35415  - stop: All session were deleted.
2025-12-07 19:51:50,317 - DEBUG - ydb.topic.35415  - close: Close topic client
2025-12-07 19:51:50,317 - DEBUG - ydb.topic.35415  - close: Topic client was closed
2025-12-07 19:51:50,317 - DEBUG - ydb.connection.35415  - close: Closing channel for endpoint localhost:15411
2025-12-07 19:51:50,318 - DEBUG - ydb.connection.35415  - close: Closing channel for endpoint ghrun-7gzmsyrbqy.auto.internal:15411
2025-12-07 19:51:50,319 - DEBUG - ydb.connection.35415  - _rpc_error_handler: RpcState(AttachSession, 9fc91c8f-c279-49f0-961e-6da2c80fd934, ghrun-7gzmsyrbqy.auto.internal:15411): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.CANCELLED
	details = "Locally cancelled by application!"
	debug_error_string = "None"
>
2025-12-07 19:51:50,321 - INFO - ydb.pool.Discovery.35415  - run: Successfully terminated discovery process
2025-12-07 19:52:12,342 - INFO - ydb.tests.library.harness.kikimr_runner.35415  - stop: Stopped node localhost:15411/1
2025-12-07 19:52:12,366 - DEBUG - library.python.filelock.35415  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/29826
2025-12-07 19:52:12,366 - DEBUG - library.python.filelock.35415  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/19759
2025-12-07 19:52:12,367 - DEBUG - library.python.filelock.35415  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/13318
2025-12-07 19:52:12,367 - DEBUG - library.python.filelock.35415  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/15411
2025-12-07 19:52:12,367 - DEBUG - library.python.filelock.35415  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/61535
