2025-10-15 15:16:46,276 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-15 15:16:46,277 - INFO - ya.test - pytest_runtest_setup: test_all_supported_compression[zstd_17_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 17]
2025-10-15 15:16:46,277 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-15 15:16:46,277 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-15 15:16:46,279 - INFO - ya.test - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_17_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 17])
2025-10-15 15:16:46,280 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:46,281 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d19d0c2d-29e3-4837-9ec7-7054fd34b45d, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:16:46,282 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d19d0c2d-29e3-4837-9ec7-7054fd34b45d, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_17_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 17)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:16:46,283 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d19d0c2d-29e3-4837-9ec7-7054fd34b45d, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:16:48,877 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:48,877 - INFO - __tests__.alter_compression - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_17_compression created
2025-10-15 15:16:48,878 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:48,878 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 25b41b18-cee0-4554-bca2-3699cf048ab2, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:16:48,879 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 25b41b18-cee0-4554-bca2-3699cf048ab2, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_17_compression`" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:16:48,881 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 25b41b18-cee0-4554-bca2-3699cf048ab2, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:16:49,516 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:49,517 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:49,517 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 38cbc322-caf8-447c-97c1-82dcb12441c7, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:16:49,518 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 38cbc322-caf8-447c-97c1-82dcb12441c7, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 0;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_17_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:16:49,520 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 38cbc322-caf8-447c-97c1-82dcb12441c7, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:16:53,804 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:53,805 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:53,806 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 88ac39c9-0e73-448d-a154-21070ddc4b80, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:16:53,807 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 88ac39c9-0e73-448d-a154-21070ddc4b80, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_17_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:16:53,808 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 88ac39c9-0e73-448d-a154-21070ddc4b80, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:16:54,641 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:54,642 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:54,643 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0d956c9f-ab8f-4a92-97a3-9120fd7f4aa6, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:16:54,644 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0d956c9f-ab8f-4a92-97a3-9120fd7f4aa6, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_17_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:16:54,646 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0d956c9f-ab8f-4a92-97a3-9120fd7f4aa6, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:16:56,187 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:56,187 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_17_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318528, 'BlobCount': 128}}
2025-10-15 15:16:56,188 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:56,189 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 52981bc0-3e81-4ceb-a443-36cc090df72f, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:16:56,190 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 52981bc0-3e81-4ceb-a443-36cc090df72f, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 100000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_17_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:16:56,191 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 52981bc0-3e81-4ceb-a443-36cc090df72f, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:16:59,724 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:59,725 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:59,726 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 94d7deb3-68c3-4e6c-bc3e-45ffee2b58fc, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:16:59,727 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 94d7deb3-68c3-4e6c-bc3e-45ffee2b58fc, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_17_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:16:59,729 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 94d7deb3-68c3-4e6c-bc3e-45ffee2b58fc, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:16:59,903 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:59,904 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:59,905 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1df0e827-4acc-4e7c-a464-48c07759c5ce, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:16:59,906 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1df0e827-4acc-4e7c-a464-48c07759c5ce, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_17_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:16:59,907 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1df0e827-4acc-4e7c-a464-48c07759c5ce, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:00,192 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:00,193 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_17_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 637920, 'BlobCount': 256}}
2025-10-15 15:17:00,193 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:00,194 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 236985bb-8503-4f87-8ee8-0df3f3f61ea7, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:17:00,195 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 236985bb-8503-4f87-8ee8-0df3f3f61ea7, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 200000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_17_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:17:00,197 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 236985bb-8503-4f87-8ee8-0df3f3f61ea7, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:03,973 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:03,974 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:03,975 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0c97040d-a44a-4fa1-9325-2eba0d444dae, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:17:03,975 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0c97040d-a44a-4fa1-9325-2eba0d444dae, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_17_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:17:03,977 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0c97040d-a44a-4fa1-9325-2eba0d444dae, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:04,182 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:04,183 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:04,183 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c2069049-d6db-4cca-9027-476819b099e1, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:17:04,184 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c2069049-d6db-4cca-9027-476819b099e1, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_17_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:17:04,185 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c2069049-d6db-4cca-9027-476819b099e1, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:04,521 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:04,522 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_17_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 181}}, blobs: {'__DEFAULT': {'Portions': 181, 'BlobSize': 961600, 'BlobCount': 384}}
2025-10-15 15:17:04,522 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:04,523 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 41f8de2e-5454-4388-abf7-68908a274d2e, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:17:04,524 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 41f8de2e-5454-4388-abf7-68908a274d2e, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 300000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_17_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:17:04,525 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 41f8de2e-5454-4388-abf7-68908a274d2e, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:08,538 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:08,539 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:08,540 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b12bbb27-56d9-4521-b475-f439f610c666, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:17:08,541 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b12bbb27-56d9-4521-b475-f439f610c666, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_17_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:17:08,542 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b12bbb27-56d9-4521-b475-f439f610c666, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:08,735 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:08,736 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:08,737 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3e436167-a92c-423d-b58e-adeff0c73945, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:17:08,738 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3e436167-a92c-423d-b58e-adeff0c73945, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_17_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:17:08,739 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3e436167-a92c-423d-b58e-adeff0c73945, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:09,079 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:09,079 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_17_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 235}}, blobs: {'__DEFAULT': {'Portions': 235, 'BlobSize': 1280144, 'BlobCount': 502}}
2025-10-15 15:17:09,080 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:09,080 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f6cde683-7b2b-4c45-adb4-12917e32085d, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:17:09,081 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f6cde683-7b2b-4c45-adb4-12917e32085d, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 400000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_17_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:17:09,083 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f6cde683-7b2b-4c45-adb4-12917e32085d, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:12,771 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:12,772 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:12,773 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d5b08ba2-0f21-40aa-9faa-eccf7cc76c35, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:17:12,774 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d5b08ba2-0f21-40aa-9faa-eccf7cc76c35, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_17_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:17:12,775 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d5b08ba2-0f21-40aa-9faa-eccf7cc76c35, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:13,195 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:13,196 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:13,197 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7b547913-a1c8-4020-b52d-b319a2d5cf29, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:17:13,198 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7b547913-a1c8-4020-b52d-b319a2d5cf29, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_17_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:17:13,200 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7b547913-a1c8-4020-b52d-b319a2d5cf29, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:13,804 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:13,805 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_17_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 290}}, blobs: {'__DEFAULT': {'Portions': 290, 'BlobSize': 1602736, 'BlobCount': 618}}
2025-10-15 15:17:13,805 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:13,806 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8e9a5f42-3520-42d7-a0cb-d8879a4d1368, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:17:13,807 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8e9a5f42-3520-42d7-a0cb-d8879a4d1368, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 500000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_17_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:17:13,809 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8e9a5f42-3520-42d7-a0cb-d8879a4d1368, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:17,560 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:17,561 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:17,561 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, eb4197b6-9233-41cd-9bd5-50e273652baa, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:17:17,563 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, eb4197b6-9233-41cd-9bd5-50e273652baa, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_17_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:17:17,565 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, eb4197b6-9233-41cd-9bd5-50e273652baa, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:17,892 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:17,893 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:17,893 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0c8bfb49-c127-4b16-8c58-3981f9ac8cda, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:17:17,895 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0c8bfb49-c127-4b16-8c58-3981f9ac8cda, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_17_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:17:17,896 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0c8bfb49-c127-4b16-8c58-3981f9ac8cda, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:18,506 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:18,507 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_17_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 354}}, blobs: {'__DEFAULT': {'Portions': 354, 'BlobSize': 1922016, 'BlobCount': 746}}
2025-10-15 15:17:18,508 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:18,509 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ff97774f-24aa-4cf2-a654-119d66739a37, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:17:18,510 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ff97774f-24aa-4cf2-a654-119d66739a37, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 600000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_17_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:17:18,511 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ff97774f-24aa-4cf2-a654-119d66739a37, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:22,617 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:22,618 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:22,619 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7d67e764-ce89-447c-bd47-560c33ec887b, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:17:22,620 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7d67e764-ce89-447c-bd47-560c33ec887b, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_17_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:17:22,625 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7d67e764-ce89-447c-bd47-560c33ec887b, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:22,926 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:22,927 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:22,927 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 04ae8bbe-e475-44ec-87ab-b9315e104a0d, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:17:22,929 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 04ae8bbe-e475-44ec-87ab-b9315e104a0d, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_17_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:17:22,930 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 04ae8bbe-e475-44ec-87ab-b9315e104a0d, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:23,577 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:23,578 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_17_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 418}}, blobs: {'__DEFAULT': {'Portions': 418, 'BlobSize': 2241056, 'BlobCount': 874}}
2025-10-15 15:17:23,579 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:23,580 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e266cbe6-3590-4f82-bd5c-0e5fae612776, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:17:23,581 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e266cbe6-3590-4f82-bd5c-0e5fae612776, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 700000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_17_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:17:23,583 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e266cbe6-3590-4f82-bd5c-0e5fae612776, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:27,709 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:27,710 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:27,711 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 791ae8bf-7f8d-48ad-8d2c-6e9384bc6255, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:17:27,712 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 791ae8bf-7f8d-48ad-8d2c-6e9384bc6255, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_17_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:17:27,714 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 791ae8bf-7f8d-48ad-8d2c-6e9384bc6255, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:28,045 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:28,046 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:28,047 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5bfacb65-8d38-4ca3-8be9-1ec2a3f5a942, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:17:28,048 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5bfacb65-8d38-4ca3-8be9-1ec2a3f5a942, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_17_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:17:28,054 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5bfacb65-8d38-4ca3-8be9-1ec2a3f5a942, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:28,821 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:28,822 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_17_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 461}}, blobs: {'__DEFAULT': {'Portions': 461, 'BlobSize': 2564424, 'BlobCount': 970}}
2025-10-15 15:17:28,822 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:28,823 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 52999bdb-273a-480f-804c-f877ae5db503, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:17:28,824 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 52999bdb-273a-480f-804c-f877ae5db503, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 800000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_17_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:17:28,826 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 52999bdb-273a-480f-804c-f877ae5db503, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:32,885 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:32,886 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:32,886 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, db0f74b3-543f-42d3-8f02-7c165ee371a7, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:17:32,887 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, db0f74b3-543f-42d3-8f02-7c165ee371a7, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_17_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:17:32,889 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, db0f74b3-543f-42d3-8f02-7c165ee371a7, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:33,237 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:33,238 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:33,238 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8e10ab52-34aa-472e-a724-f2018ae0445f, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:17:33,239 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8e10ab52-34aa-472e-a724-f2018ae0445f, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_17_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:17:33,241 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8e10ab52-34aa-472e-a724-f2018ae0445f, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:33,880 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:33,881 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_17_compression. portions: {'__DEFAULT': {'Rows': 912563, 'Portions': 444}}, blobs: {'__DEFAULT': {'Portions': 437, 'BlobSize': 2914768, 'BlobCount': 954}}
2025-10-15 15:17:33,881 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:33,882 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a8715252-5827-4314-aba3-ccfb0ddb4123, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:17:33,884 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a8715252-5827-4314-aba3-ccfb0ddb4123, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 900000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_17_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:17:33,885 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a8715252-5827-4314-aba3-ccfb0ddb4123, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:37,964 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:37,965 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:37,966 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2e51f16a-4910-4081-b13c-a9c595d5becc, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:17:37,967 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2e51f16a-4910-4081-b13c-a9c595d5becc, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_17_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:17:37,969 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2e51f16a-4910-4081-b13c-a9c595d5becc, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:38,218 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:38,219 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:38,219 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 69192f88-9678-46c9-acaf-937528a4930e, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:17:38,220 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 69192f88-9678-46c9-acaf-937528a4930e, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_17_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:17:38,222 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 69192f88-9678-46c9-acaf-937528a4930e, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:38,667 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:38,668 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_17_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 446}}, blobs: {'__DEFAULT': {'Portions': 446, 'BlobSize': 3187112, 'BlobCount': 984}}
2025-10-15 15:17:38,669 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:38,669 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8d89d5b4-04d6-497f-94b9-4a892b4f6daa, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:17:38,670 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8d89d5b4-04d6-497f-94b9-4a892b4f6daa, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_17_compression`" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:17:38,672 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8d89d5b4-04d6-497f-94b9-4a892b4f6daa, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:39,532 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:39,533 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:39,533 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b1e3dda3-905b-4f59-a842-287a754234a8, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:17:39,534 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b1e3dda3-905b-4f59-a842-287a754234a8, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_17_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:17:39,536 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b1e3dda3-905b-4f59-a842-287a754234a8, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:39,720 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:39,720 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:39,721 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 16039d2d-1203-4597-a87a-2823620167a8, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:17:39,722 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 16039d2d-1203-4597-a87a-2823620167a8, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_17_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:17:39,723 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 16039d2d-1203-4597-a87a-2823620167a8, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:39,914 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:39,915 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:39,916 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ca384fcd-926a-4af3-ae18-2a9177d906fe, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:17:39,916 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ca384fcd-926a-4af3-ae18-2a9177d906fe, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_17_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:17:39,917 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ca384fcd-926a-4af3-ae18-2a9177d906fe, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:42,487 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:52,515 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:52,516 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e646d325-3bc8-43d3-859b-af284e2b6ca4, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:17:52,517 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e646d325-3bc8-43d3-859b-af284e2b6ca4, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_17_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:17:52,518 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e646d325-3bc8-43d3-859b-af284e2b6ca4, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:17:54,208 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:17:55,694 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-15 15:17:55,695 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-10-15 15:17:55,709 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-10-15 15:17:55,710 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 9ed98c02-12d5-45a7-8567-7bfcede6c3aa, localhost:10960): creating call state
2025-10-15 15:17:55,710 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 9ed98c02-12d5-45a7-8567-7bfcede6c3aa, localhost:10960): request = { database: "/Root" }
2025-10-15 15:17:55,715 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 9ed98c02-12d5-45a7-8567-7bfcede6c3aa, localhost:10960): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-lvxbqnxafi.auto.internal" port: 10960 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-10-15 15:17:55,716 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-lvxbqnxafi.auto.internal:10960, location 1, ssl: False>]>
2025-10-15 15:17:55,717 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:10960
2025-10-15 15:18:04,223 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:18:04,224 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8fce431a-d522-4269-b82f-1c2c23f8745f, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:18:04,225 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8fce431a-d522-4269-b82f-1c2c23f8745f, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_17_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:18:04,227 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8fce431a-d522-4269-b82f-1c2c23f8745f, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:18:05,704 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:18:15,721 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:18:15,723 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, efc0e281-b809-45e5-bf21-c6a0375ec633, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:18:15,724 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, efc0e281-b809-45e5-bf21-c6a0375ec633, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_17_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:18:15,725 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, efc0e281-b809-45e5-bf21-c6a0375ec633, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:18:17,123 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:18:17,144 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_17_compression`, volumes `value` (8000000, 1544840)
2025-10-15 15:18:17,145 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:18:17,145 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 76d18d1a-5e76-4ff3-a029-230f64d1c05f, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:18:17,146 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 76d18d1a-5e76-4ff3-a029-230f64d1c05f, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_17_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:18:17,148 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 76d18d1a-5e76-4ff3-a029-230f64d1c05f, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:18:17,380 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:18:17,381 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:18:17,382 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ad0a3768-ded2-4a55-a42d-19151261ca8d, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:18:17,382 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ad0a3768-ded2-4a55-a42d-19151261ca8d, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_17_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:18:17,384 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ad0a3768-ded2-4a55-a42d-19151261ca8d, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:18:18,923 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:18:28,941 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:18:28,942 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7aa0cf48-7943-401b-b0e3-5ad57017212a, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:18:28,943 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7aa0cf48-7943-401b-b0e3-5ad57017212a, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_17_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:18:28,944 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7aa0cf48-7943-401b-b0e3-5ad57017212a, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:18:30,355 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:18:30,375 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_17_compression`, volumes `value` (8000000, 1544840)
2025-10-15 15:18:30,376 - INFO - root - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_17_compression` 8078192 / 1544840: 5.2291447658009895
2025-10-15 15:18:30,378 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-10-15 15:18:30,379 - DEBUG - ydb.connection - _prepare_call: RpcState(DeleteSession, af399dab-d08e-4dd5-98e7-e06d571e7890, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:18:30,380 - DEBUG - ydb.connection - _log_request: RpcState(DeleteSession, af399dab-d08e-4dd5-98e7-e06d571e7890, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" }
2025-10-15 15:18:30,383 - DEBUG - ydb.connection - _log_response: RpcState(DeleteSession, af399dab-d08e-4dd5-98e7-e06d571e7890, ghrun-lvxbqnxafi.auto.internal:10960): response = { status: SUCCESS }
2025-10-15 15:18:30,385 - DEBUG - ydb.query.pool - stop: All session were deleted.
2025-10-15 15:18:30,386 - DEBUG - ydb.topic - close: Close topic client
2025-10-15 15:18:30,386 - DEBUG - ydb.topic - close: Topic client was closed
2025-10-15 15:18:30,387 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:10960
2025-10-15 15:18:30,387 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(AttachSession, 0cd9065d-51f2-44fb-8d75-8cb9b405c328, ghrun-lvxbqnxafi.auto.internal:10960): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.CANCELLED
	details = "Locally cancelled by application!"
	debug_error_string = "None"
>
2025-10-15 15:18:30,388 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-lvxbqnxafi.auto.internal:10960
2025-10-15 15:18:30,393 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-10-15 15:18:42,402 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:10960/1
2025-10-15 15:18:42,403 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/9528
2025-10-15 15:18:42,405 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/8144
2025-10-15 15:18:42,406 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/9594
2025-10-15 15:18:42,407 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/10960
2025-10-15 15:18:42,407 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/61161
