2025-12-05 16:22:33,110 - INFO - ya.test.22781  - pytest_runtest_setup: ####################################################################################################
2025-12-05 16:22:33,110 - INFO - ya.test.22781  - pytest_runtest_setup: test_all_supported_compression[zstd_17_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 17]
2025-12-05 16:22:33,110 - INFO - ya.test.22781  - pytest_runtest_setup: ####################################################################################################
2025-12-05 16:22:33,111 - INFO - ya.test.22781  - pytest_runtest_setup: Test setup
2025-12-05 16:22:33,112 - INFO - ya.test.22781  - 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-05 16:22:33,112 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:33,113 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 9f9dc510-7025-41ae-b810-6cbc0a2df81d, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:22:33,113 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 9f9dc510-7025-41ae-b810-6cbc0a2df81d, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:22:33,114 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 9f9dc510-7025-41ae-b810-6cbc0a2df81d, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:22:35,373 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:35,374 - INFO - __tests__.alter_compression.22781  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_17_compression created
2025-12-05 16:22:35,401 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:35,401 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 8cf0726d-df4f-46fb-b444-1a5c17e78861, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:22:35,402 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 8cf0726d-df4f-46fb-b444-1a5c17e78861, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:22:35,402 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 8cf0726d-df4f-46fb-b444-1a5c17e78861, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:22:36,094 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:36,095 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:36,096 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, ab60b1ed-bdb1-4c37-b7b9-fbea152676ac, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:22:36,096 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, ab60b1ed-bdb1-4c37-b7b9-fbea152676ac, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:22:36,098 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, ab60b1ed-bdb1-4c37-b7b9-fbea152676ac, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:22:38,787 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:38,787 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:38,788 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 759ebe5a-3c26-4545-afba-394d579991da, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:22:38,789 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 759ebe5a-3c26-4545-afba-394d579991da, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:22:38,790 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 759ebe5a-3c26-4545-afba-394d579991da, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:22:39,438 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:39,439 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:39,439 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, f6a8b22e-7185-4159-98af-5eb0735ecce6, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:22:39,440 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, f6a8b22e-7185-4159-98af-5eb0735ecce6, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:22:39,441 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, f6a8b22e-7185-4159-98af-5eb0735ecce6, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:22:40,673 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:40,674 - INFO - __tests__.alter_compression.22781  - 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-05 16:22:40,674 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:40,675 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 4cd6c76c-2282-4bfb-bce7-8332ee4974c9, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:22:40,676 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 4cd6c76c-2282-4bfb-bce7-8332ee4974c9, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:22:40,677 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 4cd6c76c-2282-4bfb-bce7-8332ee4974c9, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:22:43,051 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:43,051 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:43,052 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, d669c909-8346-4f3d-8be4-7bca8878e534, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:22:43,052 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, d669c909-8346-4f3d-8be4-7bca8878e534, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:22:43,053 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, d669c909-8346-4f3d-8be4-7bca8878e534, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:22:43,352 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:43,353 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:43,353 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, f22270a3-00f3-4810-9db5-6f5c2784c7ad, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:22:43,354 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, f22270a3-00f3-4810-9db5-6f5c2784c7ad, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:22:43,355 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, f22270a3-00f3-4810-9db5-6f5c2784c7ad, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:22:43,754 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:43,755 - INFO - __tests__.alter_compression.22781  - 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-05 16:22:43,755 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:43,755 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, dc17c0f0-7e95-421f-a41a-33a32c2b7da6, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:22:43,756 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, dc17c0f0-7e95-421f-a41a-33a32c2b7da6, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:22:43,757 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, dc17c0f0-7e95-421f-a41a-33a32c2b7da6, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:22:46,086 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:46,087 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:46,088 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 8eec8102-a309-435e-a330-5bba44ab56d3, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:22:46,089 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 8eec8102-a309-435e-a330-5bba44ab56d3, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:22:46,090 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 8eec8102-a309-435e-a330-5bba44ab56d3, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:22:46,274 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:46,274 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:46,275 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 2831886c-b9c6-4af1-92bf-e644ed0f40b3, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:22:46,275 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 2831886c-b9c6-4af1-92bf-e644ed0f40b3, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:22:46,276 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 2831886c-b9c6-4af1-92bf-e644ed0f40b3, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:22:46,572 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:46,573 - INFO - __tests__.alter_compression.22781  - 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-05 16:22:46,573 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:46,573 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, a7a1ede1-4257-46a5-aba1-e9dd9bed2552, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:22:46,574 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, a7a1ede1-4257-46a5-aba1-e9dd9bed2552, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:22:46,575 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, a7a1ede1-4257-46a5-aba1-e9dd9bed2552, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:22:48,853 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:48,854 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:48,854 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, d6dadb0f-3439-40ce-81ec-956e76e64903, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:22:48,855 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, d6dadb0f-3439-40ce-81ec-956e76e64903, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:22:48,856 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, d6dadb0f-3439-40ce-81ec-956e76e64903, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:22:49,046 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:49,047 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:49,047 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 211406bc-bc49-41ef-9501-9eac9a53620e, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:22:49,048 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 211406bc-bc49-41ef-9501-9eac9a53620e, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:22:49,049 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 211406bc-bc49-41ef-9501-9eac9a53620e, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:22:49,329 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:49,329 - INFO - __tests__.alter_compression.22781  - 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-05 16:22:49,330 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:49,330 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 2655fa9b-34b7-45a6-834a-1f8d2b9dc60a, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:22:49,331 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 2655fa9b-34b7-45a6-834a-1f8d2b9dc60a, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:22:49,331 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 2655fa9b-34b7-45a6-834a-1f8d2b9dc60a, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:22:51,795 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:51,796 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:51,797 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 1582d3f1-6126-4b2d-b7e6-9c90ed07e0a0, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:22:51,797 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 1582d3f1-6126-4b2d-b7e6-9c90ed07e0a0, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:22:51,798 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 1582d3f1-6126-4b2d-b7e6-9c90ed07e0a0, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:22:52,024 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:52,025 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:52,026 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 760d5388-855a-4b51-b017-0e15ebb02d09, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:22:52,027 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 760d5388-855a-4b51-b017-0e15ebb02d09, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:22:52,028 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 760d5388-855a-4b51-b017-0e15ebb02d09, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:22:52,404 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:52,405 - INFO - __tests__.alter_compression.22781  - 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-05 16:22:52,405 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:52,406 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, bf601821-5862-43f3-8e3e-46057fc2eb5c, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:22:52,406 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, bf601821-5862-43f3-8e3e-46057fc2eb5c, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:22:52,407 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, bf601821-5862-43f3-8e3e-46057fc2eb5c, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:22:55,171 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:55,177 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:55,178 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 42fa06a8-f7e2-4e09-b665-4dbbf13405ed, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:22:55,179 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 42fa06a8-f7e2-4e09-b665-4dbbf13405ed, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:22:55,180 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 42fa06a8-f7e2-4e09-b665-4dbbf13405ed, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:22:55,407 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:55,431 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:55,432 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, d349cf57-110d-4fa7-b42d-6f7a7192733f, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:22:55,433 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, d349cf57-110d-4fa7-b42d-6f7a7192733f, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:22:55,434 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, d349cf57-110d-4fa7-b42d-6f7a7192733f, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:22:55,951 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:55,952 - INFO - __tests__.alter_compression.22781  - 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-05 16:22:55,953 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:55,953 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 7e9669f4-3c3e-4a5b-ae3e-c0ebb5c05a2e, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:22:55,954 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 7e9669f4-3c3e-4a5b-ae3e-c0ebb5c05a2e, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:22:55,955 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 7e9669f4-3c3e-4a5b-ae3e-c0ebb5c05a2e, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:22:58,989 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:58,990 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:58,991 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 7e8bd052-97fa-44e4-9a4d-c2ae274fda86, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:22:59,000 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 7e8bd052-97fa-44e4-9a4d-c2ae274fda86, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:22:59,010 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 7e8bd052-97fa-44e4-9a4d-c2ae274fda86, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:22:59,387 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:59,390 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:59,391 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 3902ab05-146d-4e0c-b2c8-2f2b357da341, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:22:59,392 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 3902ab05-146d-4e0c-b2c8-2f2b357da341, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:22:59,393 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 3902ab05-146d-4e0c-b2c8-2f2b357da341, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:22:59,804 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:59,812 - INFO - __tests__.alter_compression.22781  - 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-05 16:22:59,812 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:22:59,822 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, cebdd00a-af00-4294-ba7b-4c7620868534, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:22:59,832 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, cebdd00a-af00-4294-ba7b-4c7620868534, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:22:59,843 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, cebdd00a-af00-4294-ba7b-4c7620868534, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:23:03,402 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:03,403 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:03,403 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 8679a4b1-dd81-4ebf-b241-556d062aa54c, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:23:03,404 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 8679a4b1-dd81-4ebf-b241-556d062aa54c, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:23:03,406 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 8679a4b1-dd81-4ebf-b241-556d062aa54c, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:23:03,601 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:03,602 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:03,602 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 7be52003-4a61-4c90-bf26-2efcb957cbe0, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:23:03,603 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 7be52003-4a61-4c90-bf26-2efcb957cbe0, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:23:03,605 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 7be52003-4a61-4c90-bf26-2efcb957cbe0, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:23:04,126 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:04,127 - INFO - __tests__.alter_compression.22781  - 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-05 16:23:04,137 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:04,138 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, d51ce0e2-fc27-4b6f-98be-0c9335af886f, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:23:04,139 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, d51ce0e2-fc27-4b6f-98be-0c9335af886f, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:23:04,140 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, d51ce0e2-fc27-4b6f-98be-0c9335af886f, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:23:06,633 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:06,634 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:06,634 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 13c91363-cb8e-4330-9bc0-1b95ac6c6c00, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:23:06,635 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 13c91363-cb8e-4330-9bc0-1b95ac6c6c00, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:23:06,636 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 13c91363-cb8e-4330-9bc0-1b95ac6c6c00, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:23:06,803 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:06,804 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:06,804 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 588c01bf-29ce-41e6-94e2-a6d811bbc835, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:23:06,805 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 588c01bf-29ce-41e6-94e2-a6d811bbc835, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:23:06,806 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 588c01bf-29ce-41e6-94e2-a6d811bbc835, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:23:07,270 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:07,312 - INFO - __tests__.alter_compression.22781  - 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-05 16:23:07,325 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:07,333 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, b94ff684-8880-4129-9121-ab82aa7dfc00, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:23:07,344 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, b94ff684-8880-4129-9121-ab82aa7dfc00, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:23:07,345 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, b94ff684-8880-4129-9121-ab82aa7dfc00, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:23:09,797 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:09,798 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:09,799 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 9738ec76-b3ca-474d-85c1-29f52081a263, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:23:09,799 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 9738ec76-b3ca-474d-85c1-29f52081a263, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:23:09,800 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 9738ec76-b3ca-474d-85c1-29f52081a263, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:23:09,955 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:09,956 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:09,956 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, cd2bf5e4-28fa-4245-a961-65a7f4fa0bcf, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:23:09,957 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, cd2bf5e4-28fa-4245-a961-65a7f4fa0bcf, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:23:09,958 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, cd2bf5e4-28fa-4245-a961-65a7f4fa0bcf, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:23:10,490 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:10,514 - INFO - __tests__.alter_compression.22781  - 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-05 16:23:10,524 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:10,537 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 4e036fb8-e101-46ad-8c1c-1c19aac040a1, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:23:10,545 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 4e036fb8-e101-46ad-8c1c-1c19aac040a1, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:23:10,556 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 4e036fb8-e101-46ad-8c1c-1c19aac040a1, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:23:11,224 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:11,224 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:11,225 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 104bfc93-b36e-4f03-8ae5-a95a75780182, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:23:11,225 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 104bfc93-b36e-4f03-8ae5-a95a75780182, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:23:11,226 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 104bfc93-b36e-4f03-8ae5-a95a75780182, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:23:11,424 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:11,425 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:11,425 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 5242eff8-7548-40ce-9006-31bd88b0c306, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:23:11,426 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 5242eff8-7548-40ce-9006-31bd88b0c306, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:23:11,427 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 5242eff8-7548-40ce-9006-31bd88b0c306, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:23:11,618 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:11,619 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:11,619 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 283f492d-7ba4-498f-84d0-0c1e7d2cbb21, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:23:11,619 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 283f492d-7ba4-498f-84d0-0c1e7d2cbb21, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:23:11,620 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 283f492d-7ba4-498f-84d0-0c1e7d2cbb21, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:23:14,049 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:24,104 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:24,105 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, ab0a3990-e47a-4900-bce6-4e36f35a2016, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:23:24,106 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, ab0a3990-e47a-4900-bce6-4e36f35a2016, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:23:24,107 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, ab0a3990-e47a-4900-bce6-4e36f35a2016, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:23:26,375 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:26,405 - INFO - root.22781  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_17_compression`, volumes `value` (8000000, 1595704)
2025-12-05 16:23:26,405 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:26,406 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 4c611e09-62ec-4a43-92ed-7169098e6dfb, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:23:26,406 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 4c611e09-62ec-4a43-92ed-7169098e6dfb, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:23:26,407 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 4c611e09-62ec-4a43-92ed-7169098e6dfb, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:23:26,562 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:26,562 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:26,563 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, b1562002-ce0c-452b-9986-8ac8d651a158, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:23:26,564 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, b1562002-ce0c-452b-9986-8ac8d651a158, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:23:26,565 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, b1562002-ce0c-452b-9986-8ac8d651a158, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:23:28,671 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:38,718 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:38,721 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, a9a6022e-2fbc-4805-8161-0cc413b5ab24, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:23:38,722 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, a9a6022e-2fbc-4805-8161-0cc413b5ab24, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:23:38,723 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, a9a6022e-2fbc-4805-8161-0cc413b5ab24, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:23:40,742 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:44,230 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.22781  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-05 16:23:44,237 - DEBUG - ydb.connection.22781  - 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-05 16:23:44,259 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.22781  - context_resolve: Resolving endpoints for database /Root
2025-12-05 16:23:44,274 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ListEndpoints, f55470ec-9a72-4a6b-8f1f-53635897cc51, localhost:11351): creating call state
2025-12-05 16:23:44,275 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ListEndpoints, f55470ec-9a72-4a6b-8f1f-53635897cc51, localhost:11351): request = { database: "/Root" }
2025-12-05 16:23:44,279 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ListEndpoints, f55470ec-9a72-4a6b-8f1f-53635897cc51, localhost:11351): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-a66hhqwkt4.auto.internal" port: 11351 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-05 16:23:44,280 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.22781  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-a66hhqwkt4.auto.internal:11351, location 1, ssl: False>]>
2025-12-05 16:23:44,289 - DEBUG - ydb.connection.22781  - close: Closing channel for endpoint localhost:11351
2025-12-05 16:23:50,813 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:23:50,826 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 3c9d27cd-8c9f-4bfa-ae3d-4e30c2483abd, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:23:50,835 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 3c9d27cd-8c9f-4bfa-ae3d-4e30c2483abd, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:23:50,837 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 3c9d27cd-8c9f-4bfa-ae3d-4e30c2483abd, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:23:51,447 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:24:01,457 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:24:01,463 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 19dae40a-3c48-4a9c-a503-a649134f9285, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:24:01,464 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 19dae40a-3c48-4a9c-a503-a649134f9285, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:24:01,465 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 19dae40a-3c48-4a9c-a503-a649134f9285, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:24:02,682 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:24:02,688 - INFO - root.22781  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_17_compression`, volumes `value` (8000000, 1497984)
2025-12-05 16:24:02,718 - INFO - root.22781  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_17_compression` 8092160 / 1497984: 5.402033666581218
2025-12-05 16:24:02,732 - INFO - ya.test.22781  - pytest_runtest_teardown: Test teardown
2025-12-05 16:24:02,738 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(DeleteSession, beaa3c9c-cc23-419b-8626-7a803d59dfa3, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:24:02,739 - DEBUG - ydb.connection.22781  - _log_request: RpcState(DeleteSession, beaa3c9c-cc23-419b-8626-7a803d59dfa3, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" }
2025-12-05 16:24:02,744 - DEBUG - ydb.connection.22781  - _log_response: RpcState(DeleteSession, beaa3c9c-cc23-419b-8626-7a803d59dfa3, ghrun-a66hhqwkt4.auto.internal:11351): response = { status: SUCCESS }
2025-12-05 16:24:02,754 - DEBUG - ydb.query.pool.22781  - stop: All session were deleted.
2025-12-05 16:24:02,755 - DEBUG - ydb.topic.22781  - close: Close topic client
2025-12-05 16:24:02,755 - DEBUG - ydb.topic.22781  - close: Topic client was closed
2025-12-05 16:24:02,759 - DEBUG - ydb.connection.22781  - close: Closing channel for endpoint localhost:11351
2025-12-05 16:24:02,760 - DEBUG - ydb.connection.22781  - close: Closing channel for endpoint ghrun-a66hhqwkt4.auto.internal:11351
2025-12-05 16:24:02,762 - INFO - ydb.pool.Discovery.22781  - run: Successfully terminated discovery process
2025-12-05 16:24:14,821 - INFO - ydb.tests.library.harness.kikimr_runner.22781  - stop: Stopped node localhost:11351/1
2025-12-05 16:24:14,824 - DEBUG - library.python.filelock.22781  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/4861
2025-12-05 16:24:14,834 - DEBUG - library.python.filelock.22781  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/14160
2025-12-05 16:24:14,844 - DEBUG - library.python.filelock.22781  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/24772
2025-12-05 16:24:14,853 - DEBUG - library.python.filelock.22781  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/11351
2025-12-05 16:24:14,863 - DEBUG - library.python.filelock.22781  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/30554
