2025-11-01 16:18:30,481 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 16:18:30,481 - INFO - ya.test - pytest_runtest_setup: test_all_supported_compression[zstd_3_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 3]
2025-11-01 16:18:30,482 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 16:18:30,482 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-01 16:18:30,484 - INFO - ya.test - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_3_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 3])
2025-11-01 16:18:30,485 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:30,486 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 86b70c4e-46c4-45b7-ae16-d9e9127fcc25, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:30,487 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 86b70c4e-46c4-45b7-ae16-d9e9127fcc25, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_3_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 3)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:30,488 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 86b70c4e-46c4-45b7-ae16-d9e9127fcc25, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:34,232 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:34,233 - INFO - __tests__.alter_compression - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_3_compression created
2025-11-01 16:18:34,233 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:34,234 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d8340b7d-9857-41db-8e98-7aee7f54359b, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:34,235 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d8340b7d-9857-41db-8e98-7aee7f54359b, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_3_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:34,237 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d8340b7d-9857-41db-8e98-7aee7f54359b, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:35,457 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:35,458 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:35,459 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6cc58a9c-3b82-4cb1-9478-925d50904b77, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:35,463 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6cc58a9c-3b82-4cb1-9478-925d50904b77, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 0;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_3_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:35,465 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6cc58a9c-3b82-4cb1-9478-925d50904b77, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:36,839 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:36,888 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:36,889 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, eca98592-b721-4135-9e70-1a4bda114c3e, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:36,903 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, eca98592-b721-4135-9e70-1a4bda114c3e, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:36,905 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, eca98592-b721-4135-9e70-1a4bda114c3e, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:37,823 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:37,824 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:37,824 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6ebfbf5b-ec28-40a1-a459-117c0d10831f, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:37,825 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6ebfbf5b-ec28-40a1-a459-117c0d10831f, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:37,827 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6ebfbf5b-ec28-40a1-a459-117c0d10831f, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:39,419 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:39,420 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_3_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318960, 'BlobCount': 128}}
2025-11-01 16:18:39,421 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:39,421 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f22cca0a-d0dc-44b0-9c6a-4b6d6715f8c9, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:39,422 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f22cca0a-d0dc-44b0-9c6a-4b6d6715f8c9, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 100000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_3_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:39,424 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f22cca0a-d0dc-44b0-9c6a-4b6d6715f8c9, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:40,624 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:40,625 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:40,625 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 78aca129-8a56-41e2-8ed6-9e64cbefb6e9, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:40,626 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 78aca129-8a56-41e2-8ed6-9e64cbefb6e9, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:40,628 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 78aca129-8a56-41e2-8ed6-9e64cbefb6e9, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:41,116 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:41,117 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:41,118 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fea918e4-030f-4064-91cf-9b082d6b9b29, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:41,119 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fea918e4-030f-4064-91cf-9b082d6b9b29, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:41,122 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fea918e4-030f-4064-91cf-9b082d6b9b29, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:41,669 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:41,669 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_3_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 638256, 'BlobCount': 256}}
2025-11-01 16:18:41,670 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:41,671 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8bb077a1-f988-4f6d-9766-1364ebc6fb69, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:41,672 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8bb077a1-f988-4f6d-9766-1364ebc6fb69, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 200000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_3_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:41,673 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8bb077a1-f988-4f6d-9766-1364ebc6fb69, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:43,029 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:43,030 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:43,030 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3974bac5-78f5-46a0-9e14-b62a69e97a1f, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:43,031 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3974bac5-78f5-46a0-9e14-b62a69e97a1f, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:43,036 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3974bac5-78f5-46a0-9e14-b62a69e97a1f, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:43,361 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:43,362 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:43,363 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 789acf4e-65ef-4a7f-b769-9abb7c878603, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:43,364 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 789acf4e-65ef-4a7f-b769-9abb7c878603, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:43,366 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 789acf4e-65ef-4a7f-b769-9abb7c878603, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:43,881 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:43,882 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_3_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 957296, 'BlobCount': 384}}
2025-11-01 16:18:43,882 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:43,883 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7ac6ae48-e412-4636-86ce-fc8c6c48591c, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:43,884 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7ac6ae48-e412-4636-86ce-fc8c6c48591c, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 300000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_3_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:43,885 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7ac6ae48-e412-4636-86ce-fc8c6c48591c, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:45,262 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:45,268 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:45,268 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b1ff7e0f-2e41-486a-b3a6-e0f420857563, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:45,269 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b1ff7e0f-2e41-486a-b3a6-e0f420857563, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:45,270 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b1ff7e0f-2e41-486a-b3a6-e0f420857563, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:45,530 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:45,532 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:45,532 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6cd21c95-8832-44a5-85db-a479d6ca2338, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:45,533 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6cd21c95-8832-44a5-85db-a479d6ca2338, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:45,535 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6cd21c95-8832-44a5-85db-a479d6ca2338, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:45,920 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:45,921 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_3_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1276656, 'BlobCount': 512}}
2025-11-01 16:18:45,921 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:45,922 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7756544f-ee26-48a3-ad93-232669bc18e2, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:45,923 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7756544f-ee26-48a3-ad93-232669bc18e2, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 400000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_3_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:45,926 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7756544f-ee26-48a3-ad93-232669bc18e2, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:47,131 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:47,159 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:47,160 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 516147e6-d299-4c82-a097-6e5dbece8959, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:47,160 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 516147e6-d299-4c82-a097-6e5dbece8959, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:47,161 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 516147e6-d299-4c82-a097-6e5dbece8959, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:47,543 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:47,544 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:47,545 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, afaaa006-6c79-49a1-8931-0a5835d38526, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:47,546 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, afaaa006-6c79-49a1-8931-0a5835d38526, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:47,547 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, afaaa006-6c79-49a1-8931-0a5835d38526, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:47,983 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:47,984 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_3_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1595616, 'BlobCount': 640}}
2025-11-01 16:18:47,985 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:47,985 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 68a68757-a6ce-4d08-b0ef-d48f5f0eee85, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:47,986 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 68a68757-a6ce-4d08-b0ef-d48f5f0eee85, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 500000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_3_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:47,988 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 68a68757-a6ce-4d08-b0ef-d48f5f0eee85, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:49,173 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:49,174 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:49,175 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 50f5376b-5d24-4b3f-b012-90325e41f3df, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:49,176 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 50f5376b-5d24-4b3f-b012-90325e41f3df, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:49,177 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 50f5376b-5d24-4b3f-b012-90325e41f3df, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:49,437 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:49,438 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:49,438 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8eaeacd3-faef-458e-8697-9bf7610c7f8b, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:49,439 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8eaeacd3-faef-458e-8697-9bf7610c7f8b, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:49,440 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8eaeacd3-faef-458e-8697-9bf7610c7f8b, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:50,061 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:50,062 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_3_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1914800, 'BlobCount': 768}}
2025-11-01 16:18:50,062 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:50,062 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a57c3366-d42a-4313-a336-d7c57c3ebca4, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:50,063 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a57c3366-d42a-4313-a336-d7c57c3ebca4, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 600000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_3_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:50,064 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a57c3366-d42a-4313-a336-d7c57c3ebca4, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:51,245 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:51,245 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:51,246 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e142ece2-cd89-42a4-9e97-7b382af9600f, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:51,247 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e142ece2-cd89-42a4-9e97-7b382af9600f, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:51,248 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e142ece2-cd89-42a4-9e97-7b382af9600f, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:51,549 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:51,549 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:51,550 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 44fe0e15-3521-4edc-b03d-93e8e3db8293, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:51,551 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 44fe0e15-3521-4edc-b03d-93e8e3db8293, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:51,552 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 44fe0e15-3521-4edc-b03d-93e8e3db8293, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:52,051 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:52,052 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_3_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2233936, 'BlobCount': 896}}
2025-11-01 16:18:52,052 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:52,052 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 771a0d3a-110a-4a82-8bb3-00a046375cab, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:52,053 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 771a0d3a-110a-4a82-8bb3-00a046375cab, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 700000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_3_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:52,054 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 771a0d3a-110a-4a82-8bb3-00a046375cab, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:53,333 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:53,334 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:53,334 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 752b8f10-82d2-4b56-9931-c99db20cde21, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:53,335 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 752b8f10-82d2-4b56-9931-c99db20cde21, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:53,337 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 752b8f10-82d2-4b56-9931-c99db20cde21, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:53,768 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:53,768 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:53,769 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ae315464-8357-4f4e-af85-0de43569f03a, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:53,770 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ae315464-8357-4f4e-af85-0de43569f03a, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:53,776 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ae315464-8357-4f4e-af85-0de43569f03a, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:54,648 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:54,648 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_3_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2553424, 'BlobCount': 1024}}
2025-11-01 16:18:54,649 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:54,649 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 437135c3-b239-4900-baf5-907669a17c61, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:54,650 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 437135c3-b239-4900-baf5-907669a17c61, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 800000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_3_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:54,655 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 437135c3-b239-4900-baf5-907669a17c61, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:56,003 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:56,004 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:56,005 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7016a3ca-c6d4-4e3e-bb44-ce6726315c16, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:56,006 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7016a3ca-c6d4-4e3e-bb44-ce6726315c16, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:56,007 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7016a3ca-c6d4-4e3e-bb44-ce6726315c16, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:56,411 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:56,412 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:56,413 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 74212f95-8ea0-4fbd-95ac-4a6488b168f5, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:56,414 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 74212f95-8ea0-4fbd-95ac-4a6488b168f5, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:56,415 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 74212f95-8ea0-4fbd-95ac-4a6488b168f5, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:57,197 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:57,197 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_3_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2872432, 'BlobCount': 1152}}
2025-11-01 16:18:57,198 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:57,199 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fddd4d98-dd65-4d8a-bef6-534e3c44469f, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:57,200 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fddd4d98-dd65-4d8a-bef6-534e3c44469f, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 900000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_3_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:57,202 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fddd4d98-dd65-4d8a-bef6-534e3c44469f, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:58,243 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:58,244 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:58,245 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4ab22a06-b6b9-4c56-b96c-d10b1b797d53, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:58,246 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4ab22a06-b6b9-4c56-b96c-d10b1b797d53, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:58,247 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4ab22a06-b6b9-4c56-b96c-d10b1b797d53, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:58,540 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:58,541 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:58,542 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3aebc969-8573-460c-9609-30f3c6db7306, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:58,543 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3aebc969-8573-460c-9609-30f3c6db7306, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:58,544 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3aebc969-8573-460c-9609-30f3c6db7306, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:18:59,318 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:59,318 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_3_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3191936, 'BlobCount': 1280}}
2025-11-01 16:18:59,319 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:18:59,320 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 45e7a964-8bce-4ff2-adb5-f134229de124, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:18:59,320 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 45e7a964-8bce-4ff2-adb5-f134229de124, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_3_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:18:59,322 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 45e7a964-8bce-4ff2-adb5-f134229de124, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:00,655 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:19:00,662 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:19:00,663 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 037f3ce3-4784-475d-9375-e3785fa2f698, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:19:00,670 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 037f3ce3-4784-475d-9375-e3785fa2f698, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:00,672 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 037f3ce3-4784-475d-9375-e3785fa2f698, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:01,118 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:19:01,124 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:19:01,125 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 857250ef-47a6-4b99-a53c-77ffc873ab2e, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:19:01,126 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 857250ef-47a6-4b99-a53c-77ffc873ab2e, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:01,130 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 857250ef-47a6-4b99-a53c-77ffc873ab2e, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:01,516 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:19:01,530 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:19:01,531 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 046d9b8d-f1f4-4a2a-9030-a9c5f8a908dd, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:19:01,532 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 046d9b8d-f1f4-4a2a-9030-a9c5f8a908dd, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:01,534 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 046d9b8d-f1f4-4a2a-9030-a9c5f8a908dd, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:05,267 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:19:15,307 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:19:15,308 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 04feb7ee-b416-4659-878f-b2707e225f9f, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:19:15,309 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 04feb7ee-b416-4659-878f-b2707e225f9f, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:15,311 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 04feb7ee-b416-4659-878f-b2707e225f9f, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:18,800 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:19:18,840 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_3_compression`, volumes `value` (8000000, 1595968)
2025-11-01 16:19:18,841 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:19:18,842 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1d2b8cf8-b0f1-4f76-94fb-d244f08af485, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:19:18,843 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1d2b8cf8-b0f1-4f76-94fb-d244f08af485, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:18,844 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1d2b8cf8-b0f1-4f76-94fb-d244f08af485, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:19,196 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:19:19,204 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:19:19,205 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 51b7a7ff-0452-4dd2-9b0e-be340c14d5ac, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:19:19,240 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 51b7a7ff-0452-4dd2-9b0e-be340c14d5ac, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:19,242 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 51b7a7ff-0452-4dd2-9b0e-be340c14d5ac, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:23,164 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:19:33,225 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:19:33,226 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a1b53077-7e91-417d-9e34-a70c373a3ce0, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:19:33,227 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a1b53077-7e91-417d-9e34-a70c373a3ce0, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:33,232 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a1b53077-7e91-417d-9e34-a70c373a3ce0, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:36,644 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:19:46,667 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:19:46,667 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 696ff759-76f9-4a53-bc89-4e3760cd47b9, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:19:46,668 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 696ff759-76f9-4a53-bc89-4e3760cd47b9, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:46,670 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 696ff759-76f9-4a53-bc89-4e3760cd47b9, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:47,332 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:19:57,338 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:19:57,339 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 170fc617-fe4d-4cfb-a8a4-7ddfd685c4ea, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:19:57,340 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 170fc617-fe4d-4cfb-a8a4-7ddfd685c4ea, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_3_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-01 16:19:57,341 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 170fc617-fe4d-4cfb-a8a4-7ddfd685c4ea, ghrun-jzwpcuvpwq.auto.internal:23959): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:19:57,960 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=
2025-11-01 16:19:57,964 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_3_compression`, volumes `value` (8000000, 1466080)
2025-11-01 16:19:57,965 - INFO - root - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_3_compression` 8092160 / 1466080: 5.519589654043435
2025-11-01 16:19:57,966 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-11-01 16:19:57,967 - DEBUG - ydb.connection - _prepare_call: RpcState(DeleteSession, 083eba88-aa3c-4c20-b89e-bdae4f52acf4, ghrun-jzwpcuvpwq.auto.internal:23959): creating call state
2025-11-01 16:19:57,968 - DEBUG - ydb.connection - _log_request: RpcState(DeleteSession, 083eba88-aa3c-4c20-b89e-bdae4f52acf4, ghrun-jzwpcuvpwq.auto.internal:23959): request = { session_id: "ydb://session/3?node_id=1&id=YzkxMTdkMzEtMjc3NzQxMTktN2FiMThmYTYtNmMxNWNjYjY=" }
2025-11-01 16:19:57,975 - DEBUG - ydb.connection - _log_response: RpcState(DeleteSession, 083eba88-aa3c-4c20-b89e-bdae4f52acf4, ghrun-jzwpcuvpwq.auto.internal:23959): response = { status: SUCCESS }
2025-11-01 16:19:57,977 - DEBUG - ydb.query.pool - stop: All session were deleted.
2025-11-01 16:19:57,977 - DEBUG - ydb.topic - close: Close topic client
2025-11-01 16:19:57,977 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-01 16:19:57,978 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:23959
2025-11-01 16:19:57,978 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(AttachSession, 754e91a5-5bb1-41e0-973d-5889a296d2ed, ghrun-jzwpcuvpwq.auto.internal:23959): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.CANCELLED
	details = "Locally cancelled by application!"
	debug_error_string = "None"
>
2025-11-01 16:19:57,979 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-jzwpcuvpwq.auto.internal:23959
2025-11-01 16:19:57,981 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-11-01 16:20:04,992 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:23959/1
2025-11-01 16:20:04,993 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/31085
2025-11-01 16:20:04,994 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/30771
2025-11-01 16:20:04,994 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/30539
2025-11-01 16:20:04,994 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/23959
2025-11-01 16:20:04,995 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/1639
