2025-12-23 15:29:51,074 - INFO - ya.test.741679  - pytest_runtest_setup: ####################################################################################################
2025-12-23 15:29:51,075 - INFO - ya.test.741679  - pytest_runtest_setup: test_all_supported_compression[zstd_9_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 9]
2025-12-23 15:29:51,075 - INFO - ya.test.741679  - pytest_runtest_setup: ####################################################################################################
2025-12-23 15:29:51,075 - INFO - ya.test.741679  - pytest_runtest_setup: Test setup
2025-12-23 15:29:51,078 - INFO - ya.test.741679  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_9_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 9])
2025-12-23 15:29:51,078 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:29:51,079 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, f4d248d9-06a8-4e91-b7ce-6f2fc0146a81, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:29:51,080 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, f4d248d9-06a8-4e91-b7ce-6f2fc0146a81, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_9_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 9)\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 15:29:51,082 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, f4d248d9-06a8-4e91-b7ce-6f2fc0146a81, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:29:54,603 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:29:54,604 - INFO - __tests__.alter_compression.741679  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_9_compression created
2025-12-23 15:29:54,620 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:29:54,621 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, aea6c281-ea08-4dda-b4e3-db717cdc5f01, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:29:54,622 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, aea6c281-ea08-4dda-b4e3-db717cdc5f01, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_9_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:29:54,660 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, aea6c281-ea08-4dda-b4e3-db717cdc5f01, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:29:55,892 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:29:55,893 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:29:55,894 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, 6c47215a-9e88-44ba-bc54-987ebe40908b, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:29:55,895 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, 6c47215a-9e88-44ba-bc54-987ebe40908b, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:29:55,896 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, 6c47215a-9e88-44ba-bc54-987ebe40908b, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:29:58,413 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:29:58,414 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:29:58,415 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, f500415d-01b8-44b2-bc22-a067ab44e3fa, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:29:58,416 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, f500415d-01b8-44b2-bc22-a067ab44e3fa, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:29:58,417 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, f500415d-01b8-44b2-bc22-a067ab44e3fa, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:29:59,734 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:29:59,748 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:29:59,755 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, 294bffeb-58cb-446c-94ca-e25dbc6c300a, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:29:59,756 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, 294bffeb-58cb-446c-94ca-e25dbc6c300a, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:29:59,757 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, 294bffeb-58cb-446c-94ca-e25dbc6c300a, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:02,040 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:02,044 - INFO - __tests__.alter_compression.741679  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_9_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318048, 'BlobCount': 128}}
2025-12-23 15:30:02,045 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:02,051 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, bea41005-8bf5-496f-9d1e-330ca82fc221, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:02,053 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, bea41005-8bf5-496f-9d1e-330ca82fc221, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:02,077 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, bea41005-8bf5-496f-9d1e-330ca82fc221, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:03,836 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:03,837 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:03,838 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, eef70d00-58fc-4456-9c7e-af45b2fdd286, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:03,838 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, eef70d00-58fc-4456-9c7e-af45b2fdd286, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:03,848 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, eef70d00-58fc-4456-9c7e-af45b2fdd286, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:04,316 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:04,316 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:04,322 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, bcc3c17f-ad26-412b-8b23-bd441fd77ab0, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:04,323 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, bcc3c17f-ad26-412b-8b23-bd441fd77ab0, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:04,332 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, bcc3c17f-ad26-412b-8b23-bd441fd77ab0, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:04,780 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:04,780 - INFO - __tests__.alter_compression.741679  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_9_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 637344, 'BlobCount': 256}}
2025-12-23 15:30:04,787 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:04,796 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, e6afe873-1563-42c7-afef-6d17621bf013, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:04,805 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, e6afe873-1563-42c7-afef-6d17621bf013, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:04,807 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, e6afe873-1563-42c7-afef-6d17621bf013, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:07,146 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:07,147 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:07,151 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, 5a483c2f-507c-4f5e-924e-9b5519b88c99, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:07,168 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, 5a483c2f-507c-4f5e-924e-9b5519b88c99, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:07,182 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, 5a483c2f-507c-4f5e-924e-9b5519b88c99, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:07,685 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:07,704 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:07,709 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, 14eddbc4-575b-4d2c-954a-48359fca5431, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:07,710 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, 14eddbc4-575b-4d2c-954a-48359fca5431, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:07,712 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, 14eddbc4-575b-4d2c-954a-48359fca5431, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:08,284 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:08,285 - INFO - __tests__.alter_compression.741679  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_9_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 956384, 'BlobCount': 384}}
2025-12-23 15:30:08,288 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:08,288 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, ef64db5f-02ee-4bdc-a025-bfc5e8e35231, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:08,292 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, ef64db5f-02ee-4bdc-a025-bfc5e8e35231, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:08,297 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, ef64db5f-02ee-4bdc-a025-bfc5e8e35231, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:10,036 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:10,044 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:10,060 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, f7c3cade-ff63-4170-b910-754f452222b4, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:10,062 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, f7c3cade-ff63-4170-b910-754f452222b4, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:10,063 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, f7c3cade-ff63-4170-b910-754f452222b4, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:10,447 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:10,448 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:10,449 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, 7feb27f4-c6c2-44df-aeb4-22920c895305, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:10,461 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, 7feb27f4-c6c2-44df-aeb4-22920c895305, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:10,464 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, 7feb27f4-c6c2-44df-aeb4-22920c895305, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:11,359 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:11,384 - INFO - __tests__.alter_compression.741679  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_9_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1275744, 'BlobCount': 512}}
2025-12-23 15:30:11,384 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:11,419 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, 331e76d9-8210-4b30-92c1-b3d390cb8842, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:11,426 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, 331e76d9-8210-4b30-92c1-b3d390cb8842, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:11,457 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, 331e76d9-8210-4b30-92c1-b3d390cb8842, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:13,351 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:13,352 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:13,353 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, aad6f2a3-3fc4-4289-8aa7-a581a956c6df, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:13,358 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, aad6f2a3-3fc4-4289-8aa7-a581a956c6df, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:13,359 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, aad6f2a3-3fc4-4289-8aa7-a581a956c6df, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:13,947 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:13,982 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:13,987 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, 1b15e771-f431-4d75-bd93-ef793afdb1fe, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:13,988 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, 1b15e771-f431-4d75-bd93-ef793afdb1fe, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:13,993 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, 1b15e771-f431-4d75-bd93-ef793afdb1fe, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:14,651 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:14,652 - INFO - __tests__.alter_compression.741679  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_9_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1594704, 'BlobCount': 640}}
2025-12-23 15:30:14,652 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:14,658 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, 33d2bfb7-ef36-49d2-9f1e-38d7c71d919f, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:14,662 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, 33d2bfb7-ef36-49d2-9f1e-38d7c71d919f, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:14,664 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, 33d2bfb7-ef36-49d2-9f1e-38d7c71d919f, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:16,896 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:16,897 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:16,905 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, 10e59baf-322c-4c4c-aa02-9b98f1cfea2a, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:16,908 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, 10e59baf-322c-4c4c-aa02-9b98f1cfea2a, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:16,917 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, 10e59baf-322c-4c4c-aa02-9b98f1cfea2a, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:17,344 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:17,345 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:17,370 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, 5b50f234-4544-4c4e-95ca-4bdd8c5f337d, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:17,378 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, 5b50f234-4544-4c4e-95ca-4bdd8c5f337d, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:17,380 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, 5b50f234-4544-4c4e-95ca-4bdd8c5f337d, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:18,237 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:18,269 - INFO - __tests__.alter_compression.741679  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_9_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1913888, 'BlobCount': 768}}
2025-12-23 15:30:18,273 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:18,274 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, 260497dd-b3c7-4d2c-96df-c26fdd472f21, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:18,279 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, 260497dd-b3c7-4d2c-96df-c26fdd472f21, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:18,293 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, 260497dd-b3c7-4d2c-96df-c26fdd472f21, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:20,476 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:20,477 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:20,483 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, 0353cc1f-79fe-4471-b4b9-4aa01d89b3b2, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:20,484 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, 0353cc1f-79fe-4471-b4b9-4aa01d89b3b2, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:20,486 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, 0353cc1f-79fe-4471-b4b9-4aa01d89b3b2, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:20,920 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:20,926 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:20,931 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, 04943b06-2a37-48c2-bd0f-c5237ecc16fb, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:20,941 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, 04943b06-2a37-48c2-bd0f-c5237ecc16fb, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:20,942 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, 04943b06-2a37-48c2-bd0f-c5237ecc16fb, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:22,035 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:22,038 - INFO - __tests__.alter_compression.741679  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_9_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2233024, 'BlobCount': 896}}
2025-12-23 15:30:22,038 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:22,039 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, 92e7bae1-c276-4d96-b833-bb0249376129, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:22,040 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, 92e7bae1-c276-4d96-b833-bb0249376129, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:22,042 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, 92e7bae1-c276-4d96-b833-bb0249376129, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:24,005 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:24,012 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:24,017 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, 4860b7b0-59d8-463c-af88-2eda78ddb060, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:24,030 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, 4860b7b0-59d8-463c-af88-2eda78ddb060, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:24,037 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, 4860b7b0-59d8-463c-af88-2eda78ddb060, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:24,423 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:24,469 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:24,485 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, fb2be6b4-245f-47cc-a14b-de747976fa7d, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:24,491 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, fb2be6b4-245f-47cc-a14b-de747976fa7d, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:24,495 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, fb2be6b4-245f-47cc-a14b-de747976fa7d, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:25,321 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:25,325 - INFO - __tests__.alter_compression.741679  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_9_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2552512, 'BlobCount': 1024}}
2025-12-23 15:30:25,327 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:25,337 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, 77c8b3e2-ced5-418d-b4a7-43eb6ff774f0, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:25,338 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, 77c8b3e2-ced5-418d-b4a7-43eb6ff774f0, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:25,340 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, 77c8b3e2-ced5-418d-b4a7-43eb6ff774f0, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:27,102 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:27,104 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:27,109 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, ff09a786-d619-4f48-bd33-c05f51440088, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:27,109 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, ff09a786-d619-4f48-bd33-c05f51440088, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:27,124 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, ff09a786-d619-4f48-bd33-c05f51440088, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:27,450 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:27,451 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:27,451 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, c5dcd148-8ba3-4dca-aa6e-4310711f595d, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:27,452 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, c5dcd148-8ba3-4dca-aa6e-4310711f595d, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:27,454 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, c5dcd148-8ba3-4dca-aa6e-4310711f595d, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:28,115 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:28,116 - INFO - __tests__.alter_compression.741679  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_9_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2871520, 'BlobCount': 1152}}
2025-12-23 15:30:28,116 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:28,117 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, e59821e9-e801-4745-8633-e32b4512a7ad, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:28,118 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, e59821e9-e801-4745-8633-e32b4512a7ad, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:28,135 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, e59821e9-e801-4745-8633-e32b4512a7ad, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:29,699 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:29,700 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:29,701 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, f2fba4c5-9088-4ffd-ae13-d607e38e71c8, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:29,702 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, f2fba4c5-9088-4ffd-ae13-d607e38e71c8, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:29,712 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, f2fba4c5-9088-4ffd-ae13-d607e38e71c8, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:30,099 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:30,100 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:30,101 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, c0ea24dc-407a-478b-9858-768c6c62e889, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:30,102 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, c0ea24dc-407a-478b-9858-768c6c62e889, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:30,103 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, c0ea24dc-407a-478b-9858-768c6c62e889, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:30,934 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:30,934 - INFO - __tests__.alter_compression.741679  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_9_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3191024, 'BlobCount': 1280}}
2025-12-23 15:30:30,935 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:30,936 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, 0e5ea1d6-fe7c-4cc5-ac5c-5013da8b76d7, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:30,941 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, 0e5ea1d6-fe7c-4cc5-ac5c-5013da8b76d7, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_9_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:30:30,945 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, 0e5ea1d6-fe7c-4cc5-ac5c-5013da8b76d7, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:32,465 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:32,468 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:32,469 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, 1f5593d8-2191-4bc0-961a-cae6c4648f3d, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:32,473 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, 1f5593d8-2191-4bc0-961a-cae6c4648f3d, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:32,481 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, 1f5593d8-2191-4bc0-961a-cae6c4648f3d, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:32,849 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:32,850 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:32,850 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, 7ff32adb-bcc8-413e-8b98-e5d4f2947f98, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:32,851 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, 7ff32adb-bcc8-413e-8b98-e5d4f2947f98, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:32,853 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, 7ff32adb-bcc8-413e-8b98-e5d4f2947f98, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:33,131 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:33,132 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:33,133 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, ebb27ca3-dcc5-44b2-9f30-fd43379e5a34, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:33,134 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, ebb27ca3-dcc5-44b2-9f30-fd43379e5a34, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_9_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 15:30:33,136 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, ebb27ca3-dcc5-44b2-9f30-fd43379e5a34, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:36,964 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:43,484 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.741679  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-23 15:30:43,485 - DEBUG - ydb.connection.741679  - 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 15:30:43,498 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.741679  - context_resolve: Resolving endpoints for database /Root
2025-12-23 15:30:43,499 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ListEndpoints, f8589e52-56be-463b-9e3c-4fcf9bf45bcd, localhost:5073): creating call state
2025-12-23 15:30:43,501 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ListEndpoints, f8589e52-56be-463b-9e3c-4fcf9bf45bcd, localhost:5073): request = { database: "/Root" }
2025-12-23 15:30:43,507 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ListEndpoints, f8589e52-56be-463b-9e3c-4fcf9bf45bcd, localhost:5073): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-hclevy2dda.auto.internal" port: 5073 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 15:30:43,512 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.741679  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-hclevy2dda.auto.internal:5073, location 1, ssl: False>]>
2025-12-23 15:30:43,513 - DEBUG - ydb.connection.741679  - close: Closing channel for endpoint localhost:5073
2025-12-23 15:30:47,008 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:47,012 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, 730783e6-f975-42ec-b347-69733bb51581, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:47,015 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, 730783e6-f975-42ec-b347-69733bb51581, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_9_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 15:30:47,019 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, 730783e6-f975-42ec-b347-69733bb51581, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:50,468 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:50,543 - INFO - root.741679  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_9_compression`, volumes `value` (8000000, 1595512)
2025-12-23 15:30:50,548 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:50,554 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, 157df30c-0d15-4f57-9f89-40b4d3c53efe, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:50,624 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, 157df30c-0d15-4f57-9f89-40b4d3c53efe, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" 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_9_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 15:30:50,625 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, 157df30c-0d15-4f57-9f89-40b4d3c53efe, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:50,930 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:50,931 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:30:50,932 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, 29039381-9718-4bd4-8481-5453a4f7b5fa, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:30:50,934 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, 29039381-9718-4bd4-8481-5453a4f7b5fa, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_9_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 15:30:50,935 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, 29039381-9718-4bd4-8481-5453a4f7b5fa, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:30:54,672 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:31:04,752 - DEBUG - ydb.query.pool.741679  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:31:04,753 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(ExecuteQuery, 6a3f8eef-d58c-4c84-91df-b9df2da72a53, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:31:04,754 - DEBUG - ydb.connection.741679  - _log_request: RpcState(ExecuteQuery, 6a3f8eef-d58c-4c84-91df-b9df2da72a53, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_9_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 15:31:04,756 - DEBUG - ydb.connection.741679  - _log_response: RpcState(ExecuteQuery, 6a3f8eef-d58c-4c84-91df-b9df2da72a53, ghrun-hclevy2dda.auto.internal:5073): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:31:05,381 - DEBUG - ydb.query.pool.741679  - release: Session returned to queue: ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=
2025-12-23 15:31:05,386 - INFO - root.741679  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_9_compression`, volumes `value` (8000000, 1465240)
2025-12-23 15:31:05,386 - INFO - root.741679  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_9_compression` 8092160 / 1465240: 5.522753951571073
2025-12-23 15:31:05,388 - INFO - ya.test.741679  - pytest_runtest_teardown: Test teardown
2025-12-23 15:31:05,388 - DEBUG - ydb.connection.741679  - _prepare_call: RpcState(DeleteSession, a30cca91-a337-449c-b178-6d241e04d66b, ghrun-hclevy2dda.auto.internal:5073): creating call state
2025-12-23 15:31:05,389 - DEBUG - ydb.connection.741679  - _log_request: RpcState(DeleteSession, a30cca91-a337-449c-b178-6d241e04d66b, ghrun-hclevy2dda.auto.internal:5073): request = { session_id: "ydb://session/3?node_id=1&id=NGI3OWI3ODYtM2NmY2RkMDctY2U4M2M3ZjktNzdmZmQ2MjY=" }
2025-12-23 15:31:05,393 - DEBUG - ydb.connection.741679  - _log_response: RpcState(DeleteSession, a30cca91-a337-449c-b178-6d241e04d66b, ghrun-hclevy2dda.auto.internal:5073): response = { status: SUCCESS }
2025-12-23 15:31:05,394 - DEBUG - ydb.query.pool.741679  - stop: All session were deleted.
2025-12-23 15:31:05,395 - DEBUG - ydb.topic.741679  - close: Close topic client
2025-12-23 15:31:05,395 - DEBUG - ydb.topic.741679  - close: Topic client was closed
2025-12-23 15:31:05,397 - DEBUG - ydb.connection.741679  - close: Closing channel for endpoint localhost:5073
2025-12-23 15:31:05,397 - DEBUG - ydb.connection.741679  - close: Closing channel for endpoint ghrun-hclevy2dda.auto.internal:5073
2025-12-23 15:31:05,403 - INFO - ydb.pool.Discovery.741679  - run: Successfully terminated discovery process
2025-12-23 15:31:22,409 - INFO - ydb.tests.library.harness.kikimr_runner.741679  - stop: Stopped node localhost:5073/1
2025-12-23 15:31:22,411 - DEBUG - library.python.filelock.741679  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/12861
2025-12-23 15:31:22,411 - DEBUG - library.python.filelock.741679  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/32496
2025-12-23 15:31:22,413 - DEBUG - library.python.filelock.741679  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/22396
2025-12-23 15:31:22,413 - DEBUG - library.python.filelock.741679  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/5073
2025-12-23 15:31:22,414 - DEBUG - library.python.filelock.741679  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/5463
