2025-12-23 17:52:59,075 - INFO - ya.test.2335926  - pytest_runtest_setup: ####################################################################################################
2025-12-23 17:52:59,075 - INFO - ya.test.2335926  - pytest_runtest_setup: test_all_supported_compression[zstd_19_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 19]
2025-12-23 17:52:59,075 - INFO - ya.test.2335926  - pytest_runtest_setup: ####################################################################################################
2025-12-23 17:52:59,076 - INFO - ya.test.2335926  - pytest_runtest_setup: Test setup
2025-12-23 17:52:59,082 - INFO - ya.test.2335926  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_19_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 19])
2025-12-23 17:52:59,083 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:52:59,084 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 51847984-b9d6-43f8-b1d3-509eaaff6450, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:52:59,085 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 51847984-b9d6-43f8-b1d3-509eaaff6450, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_19_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 19)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:52:59,086 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 51847984-b9d6-43f8-b1d3-509eaaff6450, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:53:02,861 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:02,862 - INFO - __tests__.alter_compression.2335926  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_19_compression created
2025-12-23 17:53:02,863 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:02,863 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 425459e5-4901-4981-97a0-6826f36cff95, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:53:02,865 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 425459e5-4901-4981-97a0-6826f36cff95, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_19_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:53:02,866 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 425459e5-4901-4981-97a0-6826f36cff95, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:53:04,013 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:04,014 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:04,015 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 1bcb2446-e8ba-42a6-ae8a-53d290c42367, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:53:04,016 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 1bcb2446-e8ba-42a6-ae8a-53d290c42367, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:53:04,018 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 1bcb2446-e8ba-42a6-ae8a-53d290c42367, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:53:10,298 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:10,298 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:10,299 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, ac52191f-4228-4b4b-8a68-41ee22febd4f, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:53:10,300 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, ac52191f-4228-4b4b-8a68-41ee22febd4f, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:53:10,301 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, ac52191f-4228-4b4b-8a68-41ee22febd4f, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:53:11,334 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:11,335 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:11,335 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 42d3c6ef-ccfb-40aa-ae4b-bf613f789f21, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:53:11,336 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 42d3c6ef-ccfb-40aa-ae4b-bf613f789f21, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:53:11,340 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 42d3c6ef-ccfb-40aa-ae4b-bf613f789f21, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:53:13,618 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:13,619 - INFO - __tests__.alter_compression.2335926  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_19_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318528, 'BlobCount': 128}}
2025-12-23 17:53:13,619 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:13,620 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 61912e74-8f32-4c27-b319-5c769cc0e70a, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:53:13,626 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 61912e74-8f32-4c27-b319-5c769cc0e70a, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:53:13,633 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 61912e74-8f32-4c27-b319-5c769cc0e70a, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:53:20,086 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:20,087 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:20,087 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 81b7cfee-e5c4-4e62-977a-3bc196130833, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:53:20,088 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 81b7cfee-e5c4-4e62-977a-3bc196130833, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:53:20,090 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 81b7cfee-e5c4-4e62-977a-3bc196130833, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:53:20,476 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:20,477 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:20,477 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 5fd97a57-5d90-459d-baa1-b4e2f1cf9b0c, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:53:20,478 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 5fd97a57-5d90-459d-baa1-b4e2f1cf9b0c, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:53:20,482 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 5fd97a57-5d90-459d-baa1-b4e2f1cf9b0c, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:53:21,885 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:21,886 - INFO - __tests__.alter_compression.2335926  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_19_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 637920, 'BlobCount': 256}}
2025-12-23 17:53:21,886 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:21,887 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, e35a3de9-e608-4027-92e3-264b0fb9eaed, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:53:21,888 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, e35a3de9-e608-4027-92e3-264b0fb9eaed, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:53:21,894 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, e35a3de9-e608-4027-92e3-264b0fb9eaed, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:53:27,987 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:27,987 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:27,988 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 761ea3e8-d214-408f-9ebd-0d10cdb0e5ec, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:53:27,989 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 761ea3e8-d214-408f-9ebd-0d10cdb0e5ec, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:53:27,991 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 761ea3e8-d214-408f-9ebd-0d10cdb0e5ec, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:53:28,414 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:28,416 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:28,433 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 87aead2e-709c-4d8b-8d43-006839743386, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:53:28,434 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 87aead2e-709c-4d8b-8d43-006839743386, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:53:28,436 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 87aead2e-709c-4d8b-8d43-006839743386, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:53:29,225 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:29,226 - INFO - __tests__.alter_compression.2335926  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_19_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 956816, 'BlobCount': 384}}
2025-12-23 17:53:29,226 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:29,227 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 5bc56ba4-3921-4f02-a44d-dff53e8568a8, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:53:29,228 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 5bc56ba4-3921-4f02-a44d-dff53e8568a8, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:53:29,230 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 5bc56ba4-3921-4f02-a44d-dff53e8568a8, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:53:38,093 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:38,094 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:38,095 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, bd1efa82-532b-4fa7-ad1e-13eaccfd1db6, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:53:38,099 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, bd1efa82-532b-4fa7-ad1e-13eaccfd1db6, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:53:38,101 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, bd1efa82-532b-4fa7-ad1e-13eaccfd1db6, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:53:39,354 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:39,355 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:39,362 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 9c3ca493-5d29-47cb-8aac-880c5049a8c2, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:53:39,363 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 9c3ca493-5d29-47cb-8aac-880c5049a8c2, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:53:39,365 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 9c3ca493-5d29-47cb-8aac-880c5049a8c2, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:53:42,110 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:42,111 - INFO - __tests__.alter_compression.2335926  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_19_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1276240, 'BlobCount': 512}}
2025-12-23 17:53:42,123 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:42,124 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 7163b956-6229-4202-a061-826c97986ffb, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:53:42,125 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 7163b956-6229-4202-a061-826c97986ffb, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:53:42,126 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 7163b956-6229-4202-a061-826c97986ffb, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:53:52,152 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:52,153 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:52,154 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, c450a9a0-bad8-40a2-9d48-3f160bd28c4f, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:53:52,155 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, c450a9a0-bad8-40a2-9d48-3f160bd28c4f, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:53:52,158 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, c450a9a0-bad8-40a2-9d48-3f160bd28c4f, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:53:53,189 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:53,190 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:53,191 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 8423594f-b71b-411c-a653-d3ad65790f30, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:53:53,199 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 8423594f-b71b-411c-a653-d3ad65790f30, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:53:53,201 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 8423594f-b71b-411c-a653-d3ad65790f30, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:53:55,383 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:55,384 - INFO - __tests__.alter_compression.2335926  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_19_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1595136, 'BlobCount': 640}}
2025-12-23 17:53:55,385 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:53:55,386 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, a0cea73a-d60d-40d6-905b-0e43572adbbb, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:53:55,387 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, a0cea73a-d60d-40d6-905b-0e43572adbbb, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:53:55,389 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, a0cea73a-d60d-40d6-905b-0e43572adbbb, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:01,601 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:01,602 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:01,603 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 29e56d47-4bfe-43f9-bf65-b0a9ce75b746, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:54:01,604 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 29e56d47-4bfe-43f9-bf65-b0a9ce75b746, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:54:01,611 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 29e56d47-4bfe-43f9-bf65-b0a9ce75b746, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:02,045 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:02,046 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:02,047 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 95703d95-807e-4cf8-bb23-8fbb94763133, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:54:02,048 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 95703d95-807e-4cf8-bb23-8fbb94763133, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:54:02,052 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 95703d95-807e-4cf8-bb23-8fbb94763133, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:03,228 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:03,229 - INFO - __tests__.alter_compression.2335926  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_19_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1914416, 'BlobCount': 768}}
2025-12-23 17:54:03,229 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:03,230 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 7a266d54-f53d-407f-85df-48b98bcf8836, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:54:03,231 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 7a266d54-f53d-407f-85df-48b98bcf8836, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:54:03,236 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 7a266d54-f53d-407f-85df-48b98bcf8836, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:06,804 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335926  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-23 17:54:06,805 - DEBUG - ydb.connection.2335926  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 17:54:06,837 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335926  - context_resolve: Resolving endpoints for database /Root
2025-12-23 17:54:06,838 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ListEndpoints, 8362b637-b952-4423-94c1-7594e3eb8bba, localhost:6953): creating call state
2025-12-23 17:54:06,839 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ListEndpoints, 8362b637-b952-4423-94c1-7594e3eb8bba, localhost:6953): request = { database: "/Root" }
2025-12-23 17:54:06,854 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ListEndpoints, 8362b637-b952-4423-94c1-7594e3eb8bba, localhost:6953): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-yh5r7pxf7y.auto.internal" port: 6953 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-12-23 17:54:06,855 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335926  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-yh5r7pxf7y.auto.internal:6953, location 1, ssl: False>]>
2025-12-23 17:54:06,856 - DEBUG - ydb.connection.2335926  - close: Closing channel for endpoint localhost:6953
2025-12-23 17:54:11,085 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:11,085 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:11,086 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 06073d77-21e4-458b-aae0-56f215f61d18, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:54:11,087 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 06073d77-21e4-458b-aae0-56f215f61d18, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:54:11,091 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 06073d77-21e4-458b-aae0-56f215f61d18, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:11,754 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:11,755 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:11,756 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, a4cb98ad-bfab-48d6-bd94-eb1ad51802eb, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:54:11,757 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, a4cb98ad-bfab-48d6-bd94-eb1ad51802eb, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:54:11,758 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, a4cb98ad-bfab-48d6-bd94-eb1ad51802eb, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:13,346 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:13,347 - INFO - __tests__.alter_compression.2335926  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_19_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2233456, 'BlobCount': 896}}
2025-12-23 17:54:13,347 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:13,348 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 1460d140-f9c6-4161-be68-e8ab8ce57041, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:54:13,349 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 1460d140-f9c6-4161-be68-e8ab8ce57041, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:54:13,354 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 1460d140-f9c6-4161-be68-e8ab8ce57041, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:19,271 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:19,272 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:19,272 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 783b2e9d-a72c-4d7d-bd96-da51651560b0, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:54:19,273 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 783b2e9d-a72c-4d7d-bd96-da51651560b0, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:54:19,284 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 783b2e9d-a72c-4d7d-bd96-da51651560b0, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:19,705 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:19,706 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:19,707 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, f2263320-0d88-4277-956e-9c09cc7bc4b1, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:54:19,708 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, f2263320-0d88-4277-956e-9c09cc7bc4b1, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:54:19,710 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, f2263320-0d88-4277-956e-9c09cc7bc4b1, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:20,607 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:20,608 - INFO - __tests__.alter_compression.2335926  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_19_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2552960, 'BlobCount': 1024}}
2025-12-23 17:54:20,608 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:20,609 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 10e401df-a2da-4c7c-9bf2-b139f42ae139, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:54:20,610 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 10e401df-a2da-4c7c-9bf2-b139f42ae139, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:54:20,612 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 10e401df-a2da-4c7c-9bf2-b139f42ae139, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:28,696 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:28,697 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:28,698 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 390add9b-bf8a-4bf6-858c-d7d98671ccfc, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:54:28,699 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 390add9b-bf8a-4bf6-858c-d7d98671ccfc, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:54:28,701 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 390add9b-bf8a-4bf6-858c-d7d98671ccfc, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:29,085 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:29,086 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:29,087 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, dc6a0816-38ec-4c7d-8541-79ea65c1f89b, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:54:29,088 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, dc6a0816-38ec-4c7d-8541-79ea65c1f89b, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:54:29,102 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, dc6a0816-38ec-4c7d-8541-79ea65c1f89b, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:29,786 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:29,787 - INFO - __tests__.alter_compression.2335926  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_19_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2871840, 'BlobCount': 1152}}
2025-12-23 17:54:29,787 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:29,788 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 528e47df-af6b-4335-ba68-2a60ca4e2770, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:54:29,789 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 528e47df-af6b-4335-ba68-2a60ca4e2770, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:54:29,791 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 528e47df-af6b-4335-ba68-2a60ca4e2770, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:37,905 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:37,905 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:37,906 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 7a19ead9-f4dd-4b59-b2f1-969929e6843b, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:54:37,907 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 7a19ead9-f4dd-4b59-b2f1-969929e6843b, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:54:37,909 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 7a19ead9-f4dd-4b59-b2f1-969929e6843b, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:38,569 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:38,570 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:38,571 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, f78f4d53-82ab-45a8-861a-cd4706a95874, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:54:38,572 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, f78f4d53-82ab-45a8-861a-cd4706a95874, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:54:38,575 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, f78f4d53-82ab-45a8-861a-cd4706a95874, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:39,767 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:39,768 - INFO - __tests__.alter_compression.2335926  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_19_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3191408, 'BlobCount': 1280}}
2025-12-23 17:54:39,769 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:39,769 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, d99a7382-1b53-4bff-bd69-5afbc1078919, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:54:39,770 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, d99a7382-1b53-4bff-bd69-5afbc1078919, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_19_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:54:39,772 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, d99a7382-1b53-4bff-bd69-5afbc1078919, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:42,637 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:42,638 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:42,639 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 54e38eb3-ddfd-4b3e-aa59-9f7bd73a4628, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:54:42,640 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 54e38eb3-ddfd-4b3e-aa59-9f7bd73a4628, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:54:42,642 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 54e38eb3-ddfd-4b3e-aa59-9f7bd73a4628, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:43,277 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:43,278 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:43,279 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 49ef070e-b702-4c71-b822-243e509b5c16, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:54:43,280 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 49ef070e-b702-4c71-b822-243e509b5c16, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:54:43,289 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 49ef070e-b702-4c71-b822-243e509b5c16, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:43,781 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:43,782 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:54:43,783 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 3d05a638-249d-4fd6-be2e-d96faab3e709, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:54:43,784 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 3d05a638-249d-4fd6-be2e-d96faab3e709, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:54:43,786 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 3d05a638-249d-4fd6-be2e-d96faab3e709, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:54:50,294 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:55:00,345 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:55:00,346 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, ae874c25-d5d1-41de-89f9-7988ee4580a3, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:55:00,347 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, ae874c25-d5d1-41de-89f9-7988ee4580a3, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:55:00,354 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, ae874c25-d5d1-41de-89f9-7988ee4580a3, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:55:05,139 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:55:05,178 - INFO - root.2335926  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_19_compression`, volumes `value` (8000000, 1595704)
2025-12-23 17:55:05,179 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:55:05,179 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 007a3efa-8363-4756-b737-57eb049f6c03, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:55:05,180 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 007a3efa-8363-4756-b737-57eb049f6c03, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" 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_19_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:55:05,182 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 007a3efa-8363-4756-b737-57eb049f6c03, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:55:05,690 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:55:05,690 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:55:05,691 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 7edeaf64-e12a-4298-9ebf-4bd2bb9f4b6d, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:55:05,692 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 7edeaf64-e12a-4298-9ebf-4bd2bb9f4b6d, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:55:05,694 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 7edeaf64-e12a-4298-9ebf-4bd2bb9f4b6d, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:55:10,628 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:55:20,655 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:55:20,656 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 9c111f1b-569e-4202-8171-af8ae7c73fa8, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:55:20,657 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 9c111f1b-569e-4202-8171-af8ae7c73fa8, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:55:20,659 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 9c111f1b-569e-4202-8171-af8ae7c73fa8, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:55:24,278 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:55:34,314 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:55:34,315 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, b0fdc6c2-d3ee-492f-9582-769a80211759, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:55:34,317 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, b0fdc6c2-d3ee-492f-9582-769a80211759, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:55:34,318 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, b0fdc6c2-d3ee-492f-9582-769a80211759, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:55:35,972 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:55:45,981 - DEBUG - ydb.query.pool.2335926  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:55:45,982 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ExecuteQuery, 5adbd0d1-ade2-44d0-84e9-22f8e8b86f2d, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:55:45,983 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ExecuteQuery, 5adbd0d1-ade2-44d0-84e9-22f8e8b86f2d, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_19_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:55:45,984 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ExecuteQuery, 5adbd0d1-ade2-44d0-84e9-22f8e8b86f2d, ghrun-yh5r7pxf7y.auto.internal:6953): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:55:46,276 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335926  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-23 17:55:46,277 - DEBUG - ydb.connection.2335926  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 17:55:46,309 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335926  - context_resolve: Resolving endpoints for database /Root
2025-12-23 17:55:46,309 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(ListEndpoints, a72955c9-61b5-480f-b1a8-b0afc9e4d36d, localhost:6953): creating call state
2025-12-23 17:55:46,310 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(ListEndpoints, a72955c9-61b5-480f-b1a8-b0afc9e4d36d, localhost:6953): request = { database: "/Root" }
2025-12-23 17:55:46,443 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(ListEndpoints, a72955c9-61b5-480f-b1a8-b0afc9e4d36d, localhost:6953): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-yh5r7pxf7y.auto.internal" port: 6953 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-12-23 17:55:46,444 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335926  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-yh5r7pxf7y.auto.internal:6953, location 1, ssl: False>]>
2025-12-23 17:55:46,446 - DEBUG - ydb.connection.2335926  - close: Closing channel for endpoint localhost:6953
2025-12-23 17:55:46,959 - DEBUG - ydb.query.pool.2335926  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=
2025-12-23 17:55:46,965 - INFO - root.2335926  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_19_compression`, volumes `value` (8000000, 1465928)
2025-12-23 17:55:46,965 - INFO - root.2335926  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_19_compression` 8092160 / 1465928: 5.520161972484324
2025-12-23 17:55:46,973 - INFO - ya.test.2335926  - pytest_runtest_teardown: Test teardown
2025-12-23 17:55:46,974 - DEBUG - ydb.connection.2335926  - _prepare_call: RpcState(DeleteSession, 64fbe336-a520-4388-9ef9-0d1e639b65e9, ghrun-yh5r7pxf7y.auto.internal:6953): creating call state
2025-12-23 17:55:46,975 - DEBUG - ydb.connection.2335926  - _log_request: RpcState(DeleteSession, 64fbe336-a520-4388-9ef9-0d1e639b65e9, ghrun-yh5r7pxf7y.auto.internal:6953): request = { session_id: "ydb://session/3?node_id=1&id=YTQ3M2VjMDEtZDVmODZlYjEtYTVlZWVhZDEtN2JiY2ZjYjk=" }
2025-12-23 17:55:46,985 - DEBUG - ydb.connection.2335926  - _log_response: RpcState(DeleteSession, 64fbe336-a520-4388-9ef9-0d1e639b65e9, ghrun-yh5r7pxf7y.auto.internal:6953): response = { status: SUCCESS }
2025-12-23 17:55:46,987 - DEBUG - ydb.query.pool.2335926  - stop: All session were deleted.
2025-12-23 17:55:46,987 - DEBUG - ydb.topic.2335926  - close: Close topic client
2025-12-23 17:55:46,988 - DEBUG - ydb.topic.2335926  - close: Topic client was closed
2025-12-23 17:55:46,988 - DEBUG - ydb.connection.2335926  - close: Closing channel for endpoint localhost:6953
2025-12-23 17:55:46,990 - DEBUG - ydb.connection.2335926  - close: Closing channel for endpoint ghrun-yh5r7pxf7y.auto.internal:6953
2025-12-23 17:55:46,991 - DEBUG - ydb.connection.2335926  - _rpc_error_handler: RpcState(AttachSession, 4b34263c-a9aa-49f2-882d-e41eb5b53d4b, ghrun-yh5r7pxf7y.auto.internal:6953): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.CANCELLED
	details = "Locally cancelled by application!"
	debug_error_string = "None"
>
2025-12-23 17:55:46,997 - INFO - ydb.pool.Discovery.2335926  - run: Successfully terminated discovery process
2025-12-23 17:56:04,020 - INFO - ydb.tests.library.harness.kikimr_runner.2335926  - stop: Stopped node localhost:6953/1
2025-12-23 17:56:04,024 - DEBUG - library.python.filelock.2335926  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/9757
2025-12-23 17:56:04,027 - DEBUG - library.python.filelock.2335926  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/28202
2025-12-23 17:56:04,028 - DEBUG - library.python.filelock.2335926  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/30309
2025-12-23 17:56:04,028 - DEBUG - library.python.filelock.2335926  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/6953
2025-12-23 17:56:04,028 - DEBUG - library.python.filelock.2335926  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/20492
