2025-12-23 19:00:09,746 - INFO - ya.test.1605329  - pytest_runtest_setup: ####################################################################################################
2025-12-23 19:00:09,747 - INFO - ya.test.1605329  - pytest_runtest_setup: test_all_supported_compression[zstd_3_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 3]
2025-12-23 19:00:09,747 - INFO - ya.test.1605329  - pytest_runtest_setup: ####################################################################################################
2025-12-23 19:00:09,747 - INFO - ya.test.1605329  - pytest_runtest_setup: Test setup
2025-12-23 19:00:09,749 - INFO - ya.test.1605329  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_3_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 3])
2025-12-23 19:00:09,750 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:09,751 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 366433cc-063b-48c4-8858-8642ccf0def3, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:09,752 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 366433cc-063b-48c4-8858-8642ccf0def3, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_3_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 3)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:09,753 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 366433cc-063b-48c4-8858-8642ccf0def3, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:12,407 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:12,407 - INFO - __tests__.alter_compression.1605329  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_3_compression created
2025-12-23 19:00:12,408 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:12,409 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 6e9b3be4-f44d-4833-8340-16a7348d1681, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:12,409 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 6e9b3be4-f44d-4833-8340-16a7348d1681, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_3_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:12,411 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 6e9b3be4-f44d-4833-8340-16a7348d1681, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:13,207 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:13,208 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:13,208 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 46ae1418-c497-474b-921e-ededd974ae46, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:13,209 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 46ae1418-c497-474b-921e-ededd974ae46, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:13,211 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 46ae1418-c497-474b-921e-ededd974ae46, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:14,346 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:14,347 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:14,347 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 991d39e0-e957-4a3c-b3a9-6a1d42cd3c6f, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:14,348 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 991d39e0-e957-4a3c-b3a9-6a1d42cd3c6f, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:14,350 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 991d39e0-e957-4a3c-b3a9-6a1d42cd3c6f, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:15,054 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:15,055 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:15,055 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 39695573-4580-4d19-8d5f-b02a6c61b066, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:15,056 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 39695573-4580-4d19-8d5f-b02a6c61b066, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:15,057 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 39695573-4580-4d19-8d5f-b02a6c61b066, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:16,664 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:16,665 - INFO - __tests__.alter_compression.1605329  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_3_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318960, 'BlobCount': 128}}
2025-12-23 19:00:16,666 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:16,666 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 5a628212-ea8e-47b8-8b12-91030fafd051, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:16,667 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 5a628212-ea8e-47b8-8b12-91030fafd051, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:16,669 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 5a628212-ea8e-47b8-8b12-91030fafd051, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:18,508 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:18,508 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:18,509 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, d6565675-5e1a-4bb9-be29-7e2ecbed6b34, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:18,510 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, d6565675-5e1a-4bb9-be29-7e2ecbed6b34, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:18,511 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, d6565675-5e1a-4bb9-be29-7e2ecbed6b34, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:18,862 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:18,863 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:18,863 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 4d59895e-0580-4ad6-84fb-6fb6146156b6, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:18,864 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 4d59895e-0580-4ad6-84fb-6fb6146156b6, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:18,866 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 4d59895e-0580-4ad6-84fb-6fb6146156b6, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:19,363 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:19,363 - INFO - __tests__.alter_compression.1605329  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_3_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 638256, 'BlobCount': 256}}
2025-12-23 19:00:19,390 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:19,391 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, a3309073-6851-4749-b3cc-d03fc52b5fb7, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:19,392 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, a3309073-6851-4749-b3cc-d03fc52b5fb7, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:19,393 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, a3309073-6851-4749-b3cc-d03fc52b5fb7, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:20,559 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:20,559 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:20,560 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, d7cec31c-9d23-4144-897f-758d9407cbfd, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:20,560 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, d7cec31c-9d23-4144-897f-758d9407cbfd, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:20,562 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, d7cec31c-9d23-4144-897f-758d9407cbfd, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:20,885 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:20,886 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:20,887 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 2a07018d-f188-4f5f-bdd8-7e899ad16891, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:20,888 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 2a07018d-f188-4f5f-bdd8-7e899ad16891, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:20,890 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 2a07018d-f188-4f5f-bdd8-7e899ad16891, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:21,292 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:21,293 - INFO - __tests__.alter_compression.1605329  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_3_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 957296, 'BlobCount': 384}}
2025-12-23 19:00:21,294 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:21,295 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 5692b0ed-5c59-4c44-a3ac-7618e8b76461, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:21,296 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 5692b0ed-5c59-4c44-a3ac-7618e8b76461, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:21,297 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 5692b0ed-5c59-4c44-a3ac-7618e8b76461, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:22,241 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:22,242 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:22,243 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 591ce687-d97e-4acf-8b53-f6b2cc961d4c, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:22,244 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 591ce687-d97e-4acf-8b53-f6b2cc961d4c, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:22,245 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 591ce687-d97e-4acf-8b53-f6b2cc961d4c, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:22,695 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:22,695 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:22,696 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 1e501995-b875-4be0-bf29-d811a5cd14d2, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:22,697 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 1e501995-b875-4be0-bf29-d811a5cd14d2, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:22,698 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 1e501995-b875-4be0-bf29-d811a5cd14d2, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:23,281 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:23,282 - INFO - __tests__.alter_compression.1605329  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_3_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1276656, 'BlobCount': 512}}
2025-12-23 19:00:23,282 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:23,283 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 4e1df23e-a78f-40bc-ba52-fbe7bf795dd9, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:23,284 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 4e1df23e-a78f-40bc-ba52-fbe7bf795dd9, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:23,285 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 4e1df23e-a78f-40bc-ba52-fbe7bf795dd9, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:24,622 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:24,623 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:24,623 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 4b9ba816-13cb-4f79-a863-4439961467aa, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:24,624 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 4b9ba816-13cb-4f79-a863-4439961467aa, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:24,626 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 4b9ba816-13cb-4f79-a863-4439961467aa, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:24,892 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:24,893 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:24,893 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 72be17ab-d0a2-4ff2-95c6-0bbcfead74d7, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:24,894 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 72be17ab-d0a2-4ff2-95c6-0bbcfead74d7, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:24,895 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 72be17ab-d0a2-4ff2-95c6-0bbcfead74d7, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:25,291 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:25,292 - INFO - __tests__.alter_compression.1605329  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_3_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1595616, 'BlobCount': 640}}
2025-12-23 19:00:25,292 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:25,293 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 05b70823-7a54-46be-a7d0-3dfedf53d6e3, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:25,294 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 05b70823-7a54-46be-a7d0-3dfedf53d6e3, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:25,295 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 05b70823-7a54-46be-a7d0-3dfedf53d6e3, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:26,322 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:26,322 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:26,323 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 057f2781-5050-4a5e-b895-d0334c0ffd0c, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:26,324 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 057f2781-5050-4a5e-b895-d0334c0ffd0c, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:26,325 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 057f2781-5050-4a5e-b895-d0334c0ffd0c, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:26,570 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:26,571 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:26,572 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, c2859ca6-0391-4d90-997a-27403e3d0495, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:26,573 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, c2859ca6-0391-4d90-997a-27403e3d0495, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:26,574 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, c2859ca6-0391-4d90-997a-27403e3d0495, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:27,102 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:27,102 - INFO - __tests__.alter_compression.1605329  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_3_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1914800, 'BlobCount': 768}}
2025-12-23 19:00:27,103 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:27,104 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 40d7a0a4-fcc1-4c15-9608-f2fd9d1ee090, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:27,105 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 40d7a0a4-fcc1-4c15-9608-f2fd9d1ee090, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:27,106 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 40d7a0a4-fcc1-4c15-9608-f2fd9d1ee090, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:28,151 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:28,153 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:28,154 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, a7a919e3-b749-45be-8096-69e130dec477, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:28,154 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, a7a919e3-b749-45be-8096-69e130dec477, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:28,156 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, a7a919e3-b749-45be-8096-69e130dec477, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:28,379 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:28,380 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:28,381 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, d7a190f7-6a00-488e-a123-b6cbaf5f205b, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:28,382 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, d7a190f7-6a00-488e-a123-b6cbaf5f205b, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:28,383 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, d7a190f7-6a00-488e-a123-b6cbaf5f205b, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:28,867 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:28,868 - INFO - __tests__.alter_compression.1605329  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_3_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2233936, 'BlobCount': 896}}
2025-12-23 19:00:28,868 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:28,869 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, e16172cf-c6b7-425b-892d-fa0167b814af, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:28,870 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, e16172cf-c6b7-425b-892d-fa0167b814af, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:28,872 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, e16172cf-c6b7-425b-892d-fa0167b814af, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:30,027 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:30,028 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:30,028 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, d83420d4-1d7c-400f-ac26-9748f0a13fdd, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:30,029 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, d83420d4-1d7c-400f-ac26-9748f0a13fdd, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:30,030 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, d83420d4-1d7c-400f-ac26-9748f0a13fdd, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:30,324 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:30,325 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:30,326 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 6120469a-f0db-48e6-b458-a6fe933f8be5, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:30,327 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 6120469a-f0db-48e6-b458-a6fe933f8be5, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:30,328 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 6120469a-f0db-48e6-b458-a6fe933f8be5, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:30,945 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:30,946 - INFO - __tests__.alter_compression.1605329  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_3_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2553424, 'BlobCount': 1024}}
2025-12-23 19:00:30,946 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:30,947 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 88647e0b-e60f-4c55-926c-0332acd7c98a, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:30,948 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 88647e0b-e60f-4c55-926c-0332acd7c98a, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:30,949 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 88647e0b-e60f-4c55-926c-0332acd7c98a, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:31,978 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:31,979 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:31,980 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 4cc1502b-9d74-410c-8d31-d4b5755c93a7, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:31,981 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 4cc1502b-9d74-410c-8d31-d4b5755c93a7, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:31,982 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 4cc1502b-9d74-410c-8d31-d4b5755c93a7, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:32,261 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:32,262 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:32,262 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 07a39c0f-af4d-4203-82b9-f0e2f0ecb37c, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:32,263 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 07a39c0f-af4d-4203-82b9-f0e2f0ecb37c, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:32,264 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 07a39c0f-af4d-4203-82b9-f0e2f0ecb37c, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:32,914 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:32,915 - INFO - __tests__.alter_compression.1605329  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_3_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2872432, 'BlobCount': 1152}}
2025-12-23 19:00:32,915 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:32,916 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 5d7f3e70-16c2-4f19-9a53-0f6cfc758ae3, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:32,917 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 5d7f3e70-16c2-4f19-9a53-0f6cfc758ae3, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:32,919 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 5d7f3e70-16c2-4f19-9a53-0f6cfc758ae3, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:34,379 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:34,379 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:34,380 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 3f83ef80-67ca-461c-bbe4-d1aee0ea09c2, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:34,381 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 3f83ef80-67ca-461c-bbe4-d1aee0ea09c2, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:34,382 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 3f83ef80-67ca-461c-bbe4-d1aee0ea09c2, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:34,930 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:34,931 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:34,932 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 74992909-7460-4ed5-8550-b9d6f842767c, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:34,933 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 74992909-7460-4ed5-8550-b9d6f842767c, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:34,935 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 74992909-7460-4ed5-8550-b9d6f842767c, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:35,755 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:35,756 - INFO - __tests__.alter_compression.1605329  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_3_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3191936, 'BlobCount': 1280}}
2025-12-23 19:00:35,756 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:35,757 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 305fe882-b617-4d65-b37c-81e53a3207cb, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:35,758 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 305fe882-b617-4d65-b37c-81e53a3207cb, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_3_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:35,764 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 305fe882-b617-4d65-b37c-81e53a3207cb, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:37,240 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:37,241 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:37,242 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 86199bbe-d9c0-4e9f-839b-5cd015ab9c5b, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:37,242 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 86199bbe-d9c0-4e9f-839b-5cd015ab9c5b, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:37,244 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 86199bbe-d9c0-4e9f-839b-5cd015ab9c5b, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:37,687 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:37,688 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:37,688 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 6215624c-5ba5-4a7f-b7a0-cfcfcec5d55c, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:37,689 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 6215624c-5ba5-4a7f-b7a0-cfcfcec5d55c, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:37,691 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 6215624c-5ba5-4a7f-b7a0-cfcfcec5d55c, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:38,216 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:38,217 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:38,217 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 31d702e1-806a-4ffc-806f-caf6d549fed5, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:38,218 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 31d702e1-806a-4ffc-806f-caf6d549fed5, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:38,227 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 31d702e1-806a-4ffc-806f-caf6d549fed5, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:43,239 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:53,339 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:53,340 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 4ce86386-175a-43a1-86ef-c87f96db287a, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:53,341 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 4ce86386-175a-43a1-86ef-c87f96db287a, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:53,342 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 4ce86386-175a-43a1-86ef-c87f96db287a, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:58,586 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:58,635 - INFO - root.1605329  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_3_compression`, volumes `value` (8000000, 1595968)
2025-12-23 19:00:58,635 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:58,636 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 1f9912a7-f408-494f-90ef-c9a5c3a58d7d, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:58,637 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 1f9912a7-f408-494f-90ef-c9a5c3a58d7d, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" 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_3_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:58,639 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 1f9912a7-f408-494f-90ef-c9a5c3a58d7d, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:00:59,415 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:59,416 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:00:59,417 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 8f3e845c-7aa3-4e91-bfb1-bffb2d99e659, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:00:59,418 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 8f3e845c-7aa3-4e91-bfb1-bffb2d99e659, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:00:59,426 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 8f3e845c-7aa3-4e91-bfb1-bffb2d99e659, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:03,291 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1605329  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-23 19:01:03,291 - DEBUG - ydb.connection.1605329  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 19:01:03,323 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1605329  - context_resolve: Resolving endpoints for database /Root
2025-12-23 19:01:03,324 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ListEndpoints, ae34956d-fe6f-449e-a634-fd986b3ea7c1, localhost:29930): creating call state
2025-12-23 19:01:03,325 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ListEndpoints, ae34956d-fe6f-449e-a634-fd986b3ea7c1, localhost:29930): request = { database: "/Root" }
2025-12-23 19:01:03,377 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ListEndpoints, ae34956d-fe6f-449e-a634-fd986b3ea7c1, localhost:29930): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-ou4bsyjxme.auto.internal" port: 29930 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-12-23 19:01:03,378 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1605329  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-ou4bsyjxme.auto.internal:29930, location 1, ssl: False>]>
2025-12-23 19:01:03,380 - DEBUG - ydb.connection.1605329  - close: Closing channel for endpoint localhost:29930
2025-12-23 19:01:05,311 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:01:15,366 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:01:15,367 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, f2fc30be-8caf-4e07-9187-8bd5f21e78ba, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:01:15,369 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, f2fc30be-8caf-4e07-9187-8bd5f21e78ba, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:01:15,370 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, f2fc30be-8caf-4e07-9187-8bd5f21e78ba, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:24,024 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:01:34,056 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:01:34,057 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, deee3d2c-2bd6-499f-9768-6de4ab292c80, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:01:34,058 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, deee3d2c-2bd6-499f-9768-6de4ab292c80, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:01:34,059 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, deee3d2c-2bd6-499f-9768-6de4ab292c80, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:35,183 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:01:45,191 - DEBUG - ydb.query.pool.1605329  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:01:45,192 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(ExecuteQuery, 1d522710-246a-438b-9aaf-74537b939d74, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:01:45,193 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(ExecuteQuery, 1d522710-246a-438b-9aaf-74537b939d74, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:01:45,194 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(ExecuteQuery, 1d522710-246a-438b-9aaf-74537b939d74, ghrun-ou4bsyjxme.auto.internal:29930): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:47,430 - DEBUG - ydb.query.pool.1605329  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=
2025-12-23 19:01:47,485 - INFO - root.1605329  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_3_compression`, volumes `value` (8000000, 1466080)
2025-12-23 19:01:47,485 - INFO - root.1605329  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_3_compression` 8092160 / 1466080: 5.519589654043435
2025-12-23 19:01:47,488 - INFO - ya.test.1605329  - pytest_runtest_teardown: Test teardown
2025-12-23 19:01:47,489 - DEBUG - ydb.connection.1605329  - _prepare_call: RpcState(DeleteSession, bd066bb1-8689-4320-8b8b-412a84ff69f6, ghrun-ou4bsyjxme.auto.internal:29930): creating call state
2025-12-23 19:01:47,490 - DEBUG - ydb.connection.1605329  - _log_request: RpcState(DeleteSession, bd066bb1-8689-4320-8b8b-412a84ff69f6, ghrun-ou4bsyjxme.auto.internal:29930): request = { session_id: "ydb://session/3?node_id=1&id=MzllNTdhN2EtMmVlZmUxNjctZDU0ZWZjZWUtOTRjOTZkOWM=" }
2025-12-23 19:01:47,500 - DEBUG - ydb.connection.1605329  - _log_response: RpcState(DeleteSession, bd066bb1-8689-4320-8b8b-412a84ff69f6, ghrun-ou4bsyjxme.auto.internal:29930): response = { status: SUCCESS }
2025-12-23 19:01:47,505 - DEBUG - ydb.query.pool.1605329  - stop: All session were deleted.
2025-12-23 19:01:47,505 - DEBUG - ydb.topic.1605329  - close: Close topic client
2025-12-23 19:01:47,506 - DEBUG - ydb.topic.1605329  - close: Topic client was closed
2025-12-23 19:01:47,506 - DEBUG - ydb.connection.1605329  - close: Closing channel for endpoint localhost:29930
2025-12-23 19:01:47,514 - DEBUG - ydb.connection.1605329  - close: Closing channel for endpoint ghrun-ou4bsyjxme.auto.internal:29930
2025-12-23 19:01:47,515 - INFO - ydb.pool.Discovery.1605329  - run: Successfully terminated discovery process
2025-12-23 19:01:47,519 - DEBUG - ydb.connection.1605329  - _rpc_error_handler: RpcState(AttachSession, 0901417c-f058-4640-886c-05b27c18da45, ghrun-ou4bsyjxme.auto.internal:29930): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.CANCELLED
	details = "Locally cancelled by application!"
	debug_error_string = "None"
>
2025-12-23 19:02:09,539 - INFO - ydb.tests.library.harness.kikimr_runner.1605329  - stop: Stopped node localhost:29930/1
2025-12-23 19:02:09,543 - DEBUG - library.python.filelock.1605329  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/2115
2025-12-23 19:02:09,559 - DEBUG - library.python.filelock.1605329  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/22515
2025-12-23 19:02:09,559 - DEBUG - library.python.filelock.1605329  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/63743
2025-12-23 19:02:09,559 - DEBUG - library.python.filelock.1605329  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/29930
2025-12-23 19:02:09,560 - DEBUG - library.python.filelock.1605329  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/28567
