2025-12-04 21:07:23,887 - INFO - ya.test.687566  - pytest_runtest_setup: ####################################################################################################
2025-12-04 21:07:23,888 - INFO - ya.test.687566  - pytest_runtest_setup: test_all_supported_compression[zstd_17_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 17]
2025-12-04 21:07:23,888 - INFO - ya.test.687566  - pytest_runtest_setup: ####################################################################################################
2025-12-04 21:07:23,888 - INFO - ya.test.687566  - pytest_runtest_setup: Test setup
2025-12-04 21:07:23,889 - INFO - ya.test.687566  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_17_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 17])
2025-12-04 21:07:23,890 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:23,890 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, 80f7a5bd-3140-4fb7-a5f4-93af0e7e9b46, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:23,891 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, 80f7a5bd-3140-4fb7-a5f4-93af0e7e9b46, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_17_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 17)\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-04 21:07:23,892 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, 80f7a5bd-3140-4fb7-a5f4-93af0e7e9b46, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:07:25,650 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:25,650 - INFO - __tests__.alter_compression.687566  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_17_compression created
2025-12-04 21:07:25,651 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:25,651 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, 4f639edb-bd35-426b-b894-f3c74948ef06, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:25,652 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, 4f639edb-bd35-426b-b894-f3c74948ef06, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_17_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:07:25,653 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, 4f639edb-bd35-426b-b894-f3c74948ef06, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:07:26,109 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:26,110 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:26,111 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, 34df0181-1f56-4d8d-976d-ffaa743fe34b, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:26,112 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, 34df0181-1f56-4d8d-976d-ffaa743fe34b, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:07:26,113 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, 34df0181-1f56-4d8d-976d-ffaa743fe34b, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:07:28,777 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:28,778 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:28,778 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, 1879cc46-ddf3-4785-98c3-340aae30c616, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:28,779 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, 1879cc46-ddf3-4785-98c3-340aae30c616, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:07:28,780 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, 1879cc46-ddf3-4785-98c3-340aae30c616, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:07:29,517 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:29,518 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:29,518 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, d73e8e98-9349-4670-bacd-55a224af3c17, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:29,519 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, d73e8e98-9349-4670-bacd-55a224af3c17, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:07:29,520 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, d73e8e98-9349-4670-bacd-55a224af3c17, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:07:30,734 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:30,735 - INFO - __tests__.alter_compression.687566  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_17_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318528, 'BlobCount': 128}}
2025-12-04 21:07:30,735 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:30,736 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, b5aa4bda-cc93-44c2-a30b-73f4daebc56a, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:30,736 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, b5aa4bda-cc93-44c2-a30b-73f4daebc56a, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:07:30,737 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, b5aa4bda-cc93-44c2-a30b-73f4daebc56a, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:07:33,975 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:33,975 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:33,976 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, e562e2db-40e6-4366-9333-a64819a2c6a9, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:33,976 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, e562e2db-40e6-4366-9333-a64819a2c6a9, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:07:33,977 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, e562e2db-40e6-4366-9333-a64819a2c6a9, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:07:34,208 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:34,209 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:34,212 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, 33e9b845-3c79-49d5-bfb4-d0e1f9f25afd, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:34,217 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, 33e9b845-3c79-49d5-bfb4-d0e1f9f25afd, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:07:34,218 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, 33e9b845-3c79-49d5-bfb4-d0e1f9f25afd, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:07:34,522 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:34,523 - INFO - __tests__.alter_compression.687566  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_17_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 637920, 'BlobCount': 256}}
2025-12-04 21:07:34,523 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:34,524 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, 42cb1f53-2cd0-4d4e-80bd-2b526b24b677, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:34,525 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, 42cb1f53-2cd0-4d4e-80bd-2b526b24b677, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:07:34,526 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, 42cb1f53-2cd0-4d4e-80bd-2b526b24b677, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:07:37,364 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:37,365 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:37,366 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, e2fbdd50-da92-4052-966d-30d5d2940618, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:37,366 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, e2fbdd50-da92-4052-966d-30d5d2940618, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:07:37,367 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, e2fbdd50-da92-4052-966d-30d5d2940618, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:07:37,554 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:37,555 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:37,555 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, 145f97db-5b36-414f-96fa-5eadcbceb651, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:37,556 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, 145f97db-5b36-414f-96fa-5eadcbceb651, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:07:37,557 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, 145f97db-5b36-414f-96fa-5eadcbceb651, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:07:37,818 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:37,818 - INFO - __tests__.alter_compression.687566  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_17_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 956816, 'BlobCount': 384}}
2025-12-04 21:07:37,819 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:37,819 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, 343a9cc3-24bb-49c8-b885-21bd925eeb53, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:37,820 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, 343a9cc3-24bb-49c8-b885-21bd925eeb53, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:07:37,821 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, 343a9cc3-24bb-49c8-b885-21bd925eeb53, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:07:40,228 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:40,228 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:40,229 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, 7cd08fc5-2715-4c8f-a539-643610d29d18, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:40,229 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, 7cd08fc5-2715-4c8f-a539-643610d29d18, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:07:40,230 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, 7cd08fc5-2715-4c8f-a539-643610d29d18, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:07:40,389 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:40,390 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:40,390 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, b6286781-8689-42e0-aeeb-83fbecadb233, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:40,391 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, b6286781-8689-42e0-aeeb-83fbecadb233, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:07:40,392 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, b6286781-8689-42e0-aeeb-83fbecadb233, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:07:40,678 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:40,679 - INFO - __tests__.alter_compression.687566  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_17_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1276240, 'BlobCount': 512}}
2025-12-04 21:07:40,679 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:40,679 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, 7fcdafdf-3cbc-419a-9875-31fa524beb3f, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:40,680 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, 7fcdafdf-3cbc-419a-9875-31fa524beb3f, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:07:40,681 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, 7fcdafdf-3cbc-419a-9875-31fa524beb3f, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:07:42,957 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:42,958 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:42,959 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, ad9c335e-78a4-4b31-9797-876c2330b044, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:42,959 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, ad9c335e-78a4-4b31-9797-876c2330b044, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:07:42,960 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, ad9c335e-78a4-4b31-9797-876c2330b044, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:07:43,142 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:43,142 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:43,143 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, 2ce09391-6a03-4c10-ad96-c8f4226b424f, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:43,144 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, 2ce09391-6a03-4c10-ad96-c8f4226b424f, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:07:43,145 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, 2ce09391-6a03-4c10-ad96-c8f4226b424f, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:07:43,471 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:43,471 - INFO - __tests__.alter_compression.687566  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_17_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1595136, 'BlobCount': 640}}
2025-12-04 21:07:43,472 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:43,473 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, 96612512-c25f-4188-adf9-22b8a0ac64ba, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:43,474 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, 96612512-c25f-4188-adf9-22b8a0ac64ba, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:07:43,475 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, 96612512-c25f-4188-adf9-22b8a0ac64ba, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:07:46,420 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:46,420 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:46,421 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, dcdc326e-cb70-4848-80a8-68ba9216f6f3, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:46,422 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, dcdc326e-cb70-4848-80a8-68ba9216f6f3, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:07:46,423 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, dcdc326e-cb70-4848-80a8-68ba9216f6f3, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:07:46,617 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:46,617 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:46,618 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, 6069701b-f4a0-4019-b6f9-13cbee161dc3, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:46,619 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, 6069701b-f4a0-4019-b6f9-13cbee161dc3, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:07:46,620 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, 6069701b-f4a0-4019-b6f9-13cbee161dc3, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:07:47,025 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:47,026 - INFO - __tests__.alter_compression.687566  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_17_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1914416, 'BlobCount': 768}}
2025-12-04 21:07:47,026 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:47,027 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, 28c3c96d-1499-4772-8e48-8f63051fae92, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:47,028 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, 28c3c96d-1499-4772-8e48-8f63051fae92, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:07:47,030 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, 28c3c96d-1499-4772-8e48-8f63051fae92, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:07:49,706 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:49,707 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:49,707 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, d43a8b41-29d6-4e6b-b015-028178295577, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:49,708 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, d43a8b41-29d6-4e6b-b015-028178295577, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:07:49,710 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, d43a8b41-29d6-4e6b-b015-028178295577, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:07:49,983 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:49,983 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:49,984 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, 3b7f72de-4bb4-453a-b5c9-3ee5d2fb91ac, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:49,985 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, 3b7f72de-4bb4-453a-b5c9-3ee5d2fb91ac, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:07:49,987 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, 3b7f72de-4bb4-453a-b5c9-3ee5d2fb91ac, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:07:50,544 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:50,545 - INFO - __tests__.alter_compression.687566  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_17_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2233456, 'BlobCount': 896}}
2025-12-04 21:07:50,545 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:50,545 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, b16d42bd-4231-4fe9-97a2-8bab86b162ce, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:50,546 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, b16d42bd-4231-4fe9-97a2-8bab86b162ce, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:07:50,547 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, b16d42bd-4231-4fe9-97a2-8bab86b162ce, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:07:53,090 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:53,091 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:53,092 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, 7653a83d-38a8-4531-9e0c-8f890f0254c2, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:53,093 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, 7653a83d-38a8-4531-9e0c-8f890f0254c2, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:07:53,094 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, 7653a83d-38a8-4531-9e0c-8f890f0254c2, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:07:53,343 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:53,344 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:53,344 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, 4b6ffa4d-5a19-4dca-8589-0ad47d05549c, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:53,345 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, 4b6ffa4d-5a19-4dca-8589-0ad47d05549c, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:07:53,347 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, 4b6ffa4d-5a19-4dca-8589-0ad47d05549c, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:07:54,034 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:54,035 - INFO - __tests__.alter_compression.687566  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_17_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2552960, 'BlobCount': 1024}}
2025-12-04 21:07:54,035 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:54,036 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, 87de8443-d1f7-4102-b050-d99379a1fbd3, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:54,037 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, 87de8443-d1f7-4102-b050-d99379a1fbd3, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:07:54,038 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, 87de8443-d1f7-4102-b050-d99379a1fbd3, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:07:56,669 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:56,670 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:56,671 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, 850591dc-661f-4d78-8b52-80a8113ebd78, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:56,672 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, 850591dc-661f-4d78-8b52-80a8113ebd78, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:07:56,673 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, 850591dc-661f-4d78-8b52-80a8113ebd78, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:07:56,924 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:56,925 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:56,925 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, 9ae00e30-5a6a-48d4-a942-e527f9e2cf45, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:56,926 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, 9ae00e30-5a6a-48d4-a942-e527f9e2cf45, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:07:56,928 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, 9ae00e30-5a6a-48d4-a942-e527f9e2cf45, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:07:57,552 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:57,552 - INFO - __tests__.alter_compression.687566  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_17_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2871840, 'BlobCount': 1152}}
2025-12-04 21:07:57,553 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:07:57,553 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, 9667e86c-59e5-497b-b14a-e8e5af1275c6, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:07:57,554 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, 9667e86c-59e5-497b-b14a-e8e5af1275c6, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:07:57,555 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, 9667e86c-59e5-497b-b14a-e8e5af1275c6, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:08:00,060 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:08:00,061 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:08:00,062 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, 7e3bbb92-9075-49c4-afaf-f84024d10008, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:08:00,063 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, 7e3bbb92-9075-49c4-afaf-f84024d10008, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:08:00,064 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, 7e3bbb92-9075-49c4-afaf-f84024d10008, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:08:00,281 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:08:00,282 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:08:00,282 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, c12bb94a-cd39-4c45-9dc1-852291a760df, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:08:00,283 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, c12bb94a-cd39-4c45-9dc1-852291a760df, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:08:00,285 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, c12bb94a-cd39-4c45-9dc1-852291a760df, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:08:00,872 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:08:00,873 - INFO - __tests__.alter_compression.687566  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_17_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3191408, 'BlobCount': 1280}}
2025-12-04 21:08:00,873 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:08:00,874 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, 968bb080-8b41-4b29-9c07-b898afc8d055, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:08:00,875 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, 968bb080-8b41-4b29-9c07-b898afc8d055, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_17_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:08:00,876 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, 968bb080-8b41-4b29-9c07-b898afc8d055, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:08:01,704 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:08:01,705 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:08:01,706 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, 76691842-2f34-4e9f-8194-a3f0e89f6d71, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:08:01,707 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, 76691842-2f34-4e9f-8194-a3f0e89f6d71, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:08:01,708 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, 76691842-2f34-4e9f-8194-a3f0e89f6d71, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:08:02,010 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:08:02,011 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:08:02,011 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, a9585d0c-de39-428b-bbb7-d3d13d2f9f59, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:08:02,012 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, a9585d0c-de39-428b-bbb7-d3d13d2f9f59, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:08:02,013 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, a9585d0c-de39-428b-bbb7-d3d13d2f9f59, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:08:02,206 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:08:02,207 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:08:02,208 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, ae8167db-bb7c-4512-b649-50d9e06d2096, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:08:02,208 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, ae8167db-bb7c-4512-b649-50d9e06d2096, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_17_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-04 21:08:02,209 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, ae8167db-bb7c-4512-b649-50d9e06d2096, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:08:04,689 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:08:14,717 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:08:14,717 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, 0f284489-a5a5-4c63-931c-0ead7cff5e5c, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:08:14,718 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, 0f284489-a5a5-4c63-931c-0ead7cff5e5c, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_17_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-04 21:08:14,719 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, 0f284489-a5a5-4c63-931c-0ead7cff5e5c, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:08:15,746 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.687566  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:08:15,747 - DEBUG - ydb.connection.687566  - 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-04 21:08:15,753 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.687566  - context_resolve: Resolving endpoints for database /Root
2025-12-04 21:08:15,756 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ListEndpoints, 21ae859b-aaab-4119-8250-c704eb1c4752, localhost:6537): creating call state
2025-12-04 21:08:15,757 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ListEndpoints, 21ae859b-aaab-4119-8250-c704eb1c4752, localhost:6537): request = { database: "/Root" }
2025-12-04 21:08:15,775 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ListEndpoints, 21ae859b-aaab-4119-8250-c704eb1c4752, localhost:6537): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-fryxcz52gi.auto.internal" port: 6537 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-04 21:08:15,775 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.687566  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-fryxcz52gi.auto.internal:6537, location 1, ssl: False>]>
2025-12-04 21:08:15,776 - DEBUG - ydb.connection.687566  - close: Closing channel for endpoint localhost:6537
2025-12-04 21:08:16,517 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:08:16,545 - INFO - root.687566  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_17_compression`, volumes `value` (8000000, 1595704)
2025-12-04 21:08:16,545 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:08:16,546 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, 0942bebe-f24e-4922-9afa-180c427d3ba7, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:08:16,547 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, 0942bebe-f24e-4922-9afa-180c427d3ba7, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" 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_17_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-04 21:08:16,547 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, 0942bebe-f24e-4922-9afa-180c427d3ba7, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:08:16,701 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:08:16,702 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:08:16,702 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, e0476e14-4d7d-4789-9260-af960eb09058, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:08:16,703 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, e0476e14-4d7d-4789-9260-af960eb09058, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_17_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-04 21:08:16,704 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, e0476e14-4d7d-4789-9260-af960eb09058, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:08:18,844 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:08:28,906 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:08:28,907 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, f0474b1c-eda5-49c5-95d6-caa38aa7a89f, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:08:28,908 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, f0474b1c-eda5-49c5-95d6-caa38aa7a89f, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_17_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-04 21:08:28,909 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, f0474b1c-eda5-49c5-95d6-caa38aa7a89f, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:08:30,321 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:08:40,335 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:08:40,336 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, 1a816b59-fc53-4408-81ce-6b26a148d9ad, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:08:40,337 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, 1a816b59-fc53-4408-81ce-6b26a148d9ad, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_17_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-04 21:08:40,338 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, 1a816b59-fc53-4408-81ce-6b26a148d9ad, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:08:40,751 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:08:50,754 - DEBUG - ydb.query.pool.687566  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:08:50,755 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(ExecuteQuery, 7f75ba69-9864-4726-939c-f1ed0a3290d9, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:08:50,755 - DEBUG - ydb.connection.687566  - _log_request: RpcState(ExecuteQuery, 7f75ba69-9864-4726-939c-f1ed0a3290d9, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_17_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-04 21:08:50,756 - DEBUG - ydb.connection.687566  - _log_response: RpcState(ExecuteQuery, 7f75ba69-9864-4726-939c-f1ed0a3290d9, ghrun-fryxcz52gi.auto.internal:6537): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:08:51,124 - DEBUG - ydb.query.pool.687566  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==
2025-12-04 21:08:51,127 - INFO - root.687566  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_17_compression`, volumes `value` (8000000, 1497984)
2025-12-04 21:08:51,127 - INFO - root.687566  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_17_compression` 8092160 / 1497984: 5.402033666581218
2025-12-04 21:08:51,128 - INFO - ya.test.687566  - pytest_runtest_teardown: Test teardown
2025-12-04 21:08:51,129 - DEBUG - ydb.connection.687566  - _prepare_call: RpcState(DeleteSession, b19b15d5-0e77-467d-81f2-46da2cabe10c, ghrun-fryxcz52gi.auto.internal:6537): creating call state
2025-12-04 21:08:51,129 - DEBUG - ydb.connection.687566  - _log_request: RpcState(DeleteSession, b19b15d5-0e77-467d-81f2-46da2cabe10c, ghrun-fryxcz52gi.auto.internal:6537): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhMjFhYjYtYTRiMGNmMjAtYjVhNGI1M2QtYzViNGM4Mg==" }
2025-12-04 21:08:51,132 - DEBUG - ydb.connection.687566  - _log_response: RpcState(DeleteSession, b19b15d5-0e77-467d-81f2-46da2cabe10c, ghrun-fryxcz52gi.auto.internal:6537): response = { status: SUCCESS }
2025-12-04 21:08:51,133 - DEBUG - ydb.query.pool.687566  - stop: All session were deleted.
2025-12-04 21:08:51,133 - DEBUG - ydb.topic.687566  - close: Close topic client
2025-12-04 21:08:51,134 - DEBUG - ydb.connection.687566  - _rpc_error_handler: RpcState(AttachSession, 3d5ad181-373e-4b8a-ac1c-b79ed2e0b138, ghrun-fryxcz52gi.auto.internal:6537): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.CANCELLED
	details = "Locally cancelled by application!"
	debug_error_string = "None"
>
2025-12-04 21:08:51,135 - DEBUG - ydb.topic.687566  - close: Topic client was closed
2025-12-04 21:08:51,136 - DEBUG - ydb.connection.687566  - close: Closing channel for endpoint localhost:6537
2025-12-04 21:08:51,137 - DEBUG - ydb.connection.687566  - close: Closing channel for endpoint ghrun-fryxcz52gi.auto.internal:6537
2025-12-04 21:08:51,140 - INFO - ydb.pool.Discovery.687566  - run: Successfully terminated discovery process
2025-12-04 21:09:03,143 - INFO - ydb.tests.library.harness.kikimr_runner.687566  - stop: Stopped node localhost:6537/1
2025-12-04 21:09:03,144 - DEBUG - library.python.filelock.687566  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/11393
2025-12-04 21:09:03,144 - DEBUG - library.python.filelock.687566  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/19896
2025-12-04 21:09:03,145 - DEBUG - library.python.filelock.687566  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/27210
2025-12-04 21:09:03,145 - DEBUG - library.python.filelock.687566  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/6537
2025-12-04 21:09:03,145 - DEBUG - library.python.filelock.687566  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/11304
