2025-11-01 16:21:43,756 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 16:21:43,758 - INFO - ya.test - pytest_runtest_setup: test_all_supported_compression[zstd_3_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 3]
2025-11-01 16:21:43,758 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 16:21:43,759 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-01 16:21:43,761 - 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:21:43,762 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:43,762 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ead0c3db-f2fc-4f83-8f07-0bded982d2f2, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:21:43,763 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ead0c3db-f2fc-4f83-8f07-0bded982d2f2, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:21:43,765 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ead0c3db-f2fc-4f83-8f07-0bded982d2f2, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:46,497 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:46,498 - INFO - __tests__.alter_compression - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_3_compression created
2025-11-01 16:21:46,498 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:46,499 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 308637d4-84a8-4a2f-8d13-7bddd69a7860, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:21:46,500 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 308637d4-84a8-4a2f-8d13-7bddd69a7860, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:21:46,501 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 308637d4-84a8-4a2f-8d13-7bddd69a7860, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:47,357 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:47,358 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:47,358 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9817e426-ae9b-4a49-9f53-f3f888fa9d3e, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:21:47,359 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9817e426-ae9b-4a49-9f53-f3f888fa9d3e, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:21:47,361 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9817e426-ae9b-4a49-9f53-f3f888fa9d3e, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:48,749 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:48,750 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:48,751 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f4f44ee9-3abb-470a-9cf4-995af8f1f7eb, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:21:48,751 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f4f44ee9-3abb-470a-9cf4-995af8f1f7eb, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:21:48,752 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f4f44ee9-3abb-470a-9cf4-995af8f1f7eb, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:49,588 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:49,589 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:49,590 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 90135964-c610-4c56-842d-b09ed3d8c394, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:21:49,590 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 90135964-c610-4c56-842d-b09ed3d8c394, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:21:49,592 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 90135964-c610-4c56-842d-b09ed3d8c394, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:51,120 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:51,120 - 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:21:51,121 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:51,121 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f351127f-ae68-437e-8d82-a3f71f2f142b, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:21:51,122 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f351127f-ae68-437e-8d82-a3f71f2f142b, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:21:51,123 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f351127f-ae68-437e-8d82-a3f71f2f142b, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:52,265 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:52,265 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:52,266 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6c398589-52ce-48a8-8219-d680c0a4fe73, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:21:52,267 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6c398589-52ce-48a8-8219-d680c0a4fe73, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:21:52,268 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6c398589-52ce-48a8-8219-d680c0a4fe73, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:52,515 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:52,516 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:52,516 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, adafa199-c9fd-4a3f-bee1-2b1fe10b1f5f, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:21:52,517 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, adafa199-c9fd-4a3f-bee1-2b1fe10b1f5f, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:21:52,518 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, adafa199-c9fd-4a3f-bee1-2b1fe10b1f5f, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:52,791 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:52,791 - 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:21:52,792 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:52,793 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a8b2af0c-1337-46c6-a3d5-f712f3da6b57, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:21:52,794 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a8b2af0c-1337-46c6-a3d5-f712f3da6b57, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:21:52,796 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a8b2af0c-1337-46c6-a3d5-f712f3da6b57, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:53,888 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:53,889 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:53,889 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, efa14042-3d76-411e-86fb-9c93422a0639, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:21:53,890 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, efa14042-3d76-411e-86fb-9c93422a0639, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:21:53,891 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, efa14042-3d76-411e-86fb-9c93422a0639, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:54,192 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:54,192 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:54,193 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b625e945-3feb-422b-bdba-cefd98a61b2f, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:21:54,194 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b625e945-3feb-422b-bdba-cefd98a61b2f, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:21:54,195 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b625e945-3feb-422b-bdba-cefd98a61b2f, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:54,558 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:54,559 - 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:21:54,559 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:54,560 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0e8901a7-83d0-4d4d-bd33-fab89e037b44, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:21:54,561 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0e8901a7-83d0-4d4d-bd33-fab89e037b44, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:21:54,563 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0e8901a7-83d0-4d4d-bd33-fab89e037b44, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:55,698 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:55,699 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:55,700 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d2456917-959c-4167-bf7e-fab6f7b8312a, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:21:55,701 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d2456917-959c-4167-bf7e-fab6f7b8312a, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:21:55,702 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d2456917-959c-4167-bf7e-fab6f7b8312a, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:55,967 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:55,968 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:55,969 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d41d37f5-1e4e-40e0-902a-423811cb5b84, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:21:55,969 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d41d37f5-1e4e-40e0-902a-423811cb5b84, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:21:55,971 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d41d37f5-1e4e-40e0-902a-423811cb5b84, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:56,377 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:56,378 - 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:21:56,378 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:56,379 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 24325df7-2647-4a09-b0e0-ab7115f4d184, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:21:56,379 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 24325df7-2647-4a09-b0e0-ab7115f4d184, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:21:56,381 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 24325df7-2647-4a09-b0e0-ab7115f4d184, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:57,486 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:57,487 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:57,488 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8468fb9e-1177-4025-a6a8-8c0d22eab8ad, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:21:57,489 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8468fb9e-1177-4025-a6a8-8c0d22eab8ad, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:21:57,491 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8468fb9e-1177-4025-a6a8-8c0d22eab8ad, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:57,843 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:57,844 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:57,845 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 174228a0-d49d-4e02-8169-c43493eb0f32, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:21:57,846 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 174228a0-d49d-4e02-8169-c43493eb0f32, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:21:57,849 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 174228a0-d49d-4e02-8169-c43493eb0f32, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:58,306 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:58,307 - 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:21:58,308 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:58,309 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 594c7595-eec9-442c-ab05-9e5081f4533c, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:21:58,347 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 594c7595-eec9-442c-ab05-9e5081f4533c, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:21:58,349 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 594c7595-eec9-442c-ab05-9e5081f4533c, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:59,618 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:59,618 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:59,619 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1967ec68-bfa1-4385-ac8b-45bc20aa9399, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:21:59,620 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1967ec68-bfa1-4385-ac8b-45bc20aa9399, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:21:59,621 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1967ec68-bfa1-4385-ac8b-45bc20aa9399, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:21:59,860 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:59,861 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:21:59,862 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7faa1755-282c-43b4-949a-0ee7a2242e47, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:21:59,863 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7faa1755-282c-43b4-949a-0ee7a2242e47, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:21:59,865 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7faa1755-282c-43b4-949a-0ee7a2242e47, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:22:00,335 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:00,335 - 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:22:00,336 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:00,337 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6327f798-6edb-4693-b46b-5c4849bff1f8, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:22:00,338 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6327f798-6edb-4693-b46b-5c4849bff1f8, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:22:00,339 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6327f798-6edb-4693-b46b-5c4849bff1f8, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:22:01,619 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:01,619 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:01,620 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e3d6eba3-bcde-4af3-8071-3c9bed276735, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:22:01,621 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e3d6eba3-bcde-4af3-8071-3c9bed276735, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:22:01,622 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e3d6eba3-bcde-4af3-8071-3c9bed276735, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:22:01,857 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:01,858 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:01,858 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4b319b69-651b-4736-a520-6319a72b9dc7, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:22:01,859 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4b319b69-651b-4736-a520-6319a72b9dc7, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:22:01,861 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4b319b69-651b-4736-a520-6319a72b9dc7, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:22:02,329 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:02,330 - 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:22:02,330 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:02,330 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ade92b65-0b65-4fd0-800b-57ea8fe56a5d, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:22:02,331 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ade92b65-0b65-4fd0-800b-57ea8fe56a5d, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:22:02,333 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ade92b65-0b65-4fd0-800b-57ea8fe56a5d, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:22:03,672 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:03,672 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:03,673 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2fe17fb8-66d3-4bc6-ab4b-a408351830e0, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:22:03,674 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2fe17fb8-66d3-4bc6-ab4b-a408351830e0, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:22:03,675 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2fe17fb8-66d3-4bc6-ab4b-a408351830e0, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:22:03,929 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:03,929 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:03,930 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 95934376-06c7-406c-aa0f-75965134cad2, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:22:03,930 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 95934376-06c7-406c-aa0f-75965134cad2, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:22:03,932 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 95934376-06c7-406c-aa0f-75965134cad2, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:22:04,537 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:04,537 - 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:22:04,538 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:04,538 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6586817f-de51-43b2-8fa0-4d47afcb8530, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:22:04,539 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6586817f-de51-43b2-8fa0-4d47afcb8530, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:22:04,542 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6586817f-de51-43b2-8fa0-4d47afcb8530, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:22:05,653 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:05,654 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:05,654 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d86ced2f-e387-4366-a303-4b35c3bafbae, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:22:05,655 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d86ced2f-e387-4366-a303-4b35c3bafbae, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:22:05,665 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d86ced2f-e387-4366-a303-4b35c3bafbae, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:22:05,920 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:05,921 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:05,921 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e503228d-e56d-4a4b-9508-c083eb363b6a, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:22:05,922 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e503228d-e56d-4a4b-9508-c083eb363b6a, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:22:05,924 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e503228d-e56d-4a4b-9508-c083eb363b6a, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:22:06,485 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:06,486 - 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:22:06,486 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:06,487 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0e4358a7-464f-4d36-995e-4981338019c6, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:22:06,488 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0e4358a7-464f-4d36-995e-4981338019c6, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:22:06,489 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0e4358a7-464f-4d36-995e-4981338019c6, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:22:07,657 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:07,658 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:07,658 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e3188eab-a030-43c1-b4ae-dc455eb9283e, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:22:07,660 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e3188eab-a030-43c1-b4ae-dc455eb9283e, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:22:07,662 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e3188eab-a030-43c1-b4ae-dc455eb9283e, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:22:08,007 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:08,008 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:08,008 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, dc9cfbc7-3243-4dc4-a0ba-561bd0326202, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:22:08,009 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, dc9cfbc7-3243-4dc4-a0ba-561bd0326202, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:22:08,011 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, dc9cfbc7-3243-4dc4-a0ba-561bd0326202, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:22:08,741 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:08,742 - 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:22:08,742 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:08,743 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d06f0a2a-2ee6-4be8-a112-d4681a05396f, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:22:08,744 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d06f0a2a-2ee6-4be8-a112-d4681a05396f, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:22:08,746 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d06f0a2a-2ee6-4be8-a112-d4681a05396f, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:22:09,988 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:09,989 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:09,989 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a254df6b-f7fd-43ed-8d9c-ba98a2f74e83, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:22:09,990 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a254df6b-f7fd-43ed-8d9c-ba98a2f74e83, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:22:09,992 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a254df6b-f7fd-43ed-8d9c-ba98a2f74e83, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:22:10,337 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:10,338 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:10,339 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ccaf97cd-aec6-468b-b83c-a11b42261b7f, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:22:10,339 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ccaf97cd-aec6-468b-b83c-a11b42261b7f, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:22:10,341 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ccaf97cd-aec6-468b-b83c-a11b42261b7f, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:22:10,389 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 16:22:10,390 - 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-11-01 16:22:10,416 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-01 16:22:10,416 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 6d9b1028-ac5c-462c-8f91-8836caf6cc1e, localhost:10003): creating call state
2025-11-01 16:22:10,417 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 6d9b1028-ac5c-462c-8f91-8836caf6cc1e, localhost:10003): request = { database: "/Root" }
2025-11-01 16:22:10,438 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 6d9b1028-ac5c-462c-8f91-8836caf6cc1e, localhost:10003): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-cjocww3of4.auto.internal" port: 10003 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-11-01 16:22:10,439 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-cjocww3of4.auto.internal:10003, location 1, ssl: False>]>
2025-11-01 16:22:10,439 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:10003
2025-11-01 16:22:10,720 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:10,720 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:10,721 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d76a24f4-2ac1-48de-921a-191e8a0517cf, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:22:10,722 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d76a24f4-2ac1-48de-921a-191e8a0517cf, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:22:10,724 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d76a24f4-2ac1-48de-921a-191e8a0517cf, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:22:15,396 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:25,441 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:25,441 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6901a5ce-e373-4d81-a830-445322109654, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:22:25,442 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6901a5ce-e373-4d81-a830-445322109654, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:22:25,444 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6901a5ce-e373-4d81-a830-445322109654, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:22:29,184 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:29,219 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_3_compression`, volumes `value` (8000000, 1595968)
2025-11-01 16:22:29,219 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:29,220 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 79810dc9-8e9c-4b07-9c68-a1caaf8e6e60, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:22:29,221 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 79810dc9-8e9c-4b07-9c68-a1caaf8e6e60, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:22:29,222 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 79810dc9-8e9c-4b07-9c68-a1caaf8e6e60, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:22:29,505 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:29,505 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:29,506 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c5aa45f9-f986-49af-9eca-982bcdce1359, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:22:29,506 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c5aa45f9-f986-49af-9eca-982bcdce1359, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:22:29,507 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c5aa45f9-f986-49af-9eca-982bcdce1359, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:22:32,957 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:42,988 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:42,988 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fa83e0aa-f5f9-4b38-86fe-e5869dfa42de, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:22:42,989 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fa83e0aa-f5f9-4b38-86fe-e5869dfa42de, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" 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:22:42,990 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fa83e0aa-f5f9-4b38-86fe-e5869dfa42de, ghrun-cjocww3of4.auto.internal:10003): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:22:46,684 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=
2025-11-01 16:22:46,757 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_3_compression`, volumes `value` (8000000, 1595968)
2025-11-01 16:22:46,757 - INFO - root - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_3_compression` 8092160 / 1595968: 5.070377350924329
2025-11-01 16:22:46,758 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-11-01 16:22:46,759 - DEBUG - ydb.connection - _prepare_call: RpcState(DeleteSession, 385f6099-4a8d-47c0-a17b-89752ba1d50a, ghrun-cjocww3of4.auto.internal:10003): creating call state
2025-11-01 16:22:46,759 - DEBUG - ydb.connection - _log_request: RpcState(DeleteSession, 385f6099-4a8d-47c0-a17b-89752ba1d50a, ghrun-cjocww3of4.auto.internal:10003): request = { session_id: "ydb://session/3?node_id=1&id=NDUwMjMzMzYtNGM5NTZkZmQtNjJlOWU3OTAtNmM3YzRlYzE=" }
2025-11-01 16:22:46,762 - DEBUG - ydb.connection - _log_response: RpcState(DeleteSession, 385f6099-4a8d-47c0-a17b-89752ba1d50a, ghrun-cjocww3of4.auto.internal:10003): response = { status: SUCCESS }
2025-11-01 16:22:46,763 - DEBUG - ydb.query.pool - stop: All session were deleted.
2025-11-01 16:22:46,764 - DEBUG - ydb.topic - close: Close topic client
2025-11-01 16:22:46,764 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-01 16:22:46,765 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(AttachSession, be09e298-7d5f-41e0-b54d-6201c764dbf3, ghrun-cjocww3of4.auto.internal:10003): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.CANCELLED
	details = "Locally cancelled by application!"
	debug_error_string = "None"
>
2025-11-01 16:22:46,766 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:10003
2025-11-01 16:22:46,766 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-cjocww3of4.auto.internal:10003
2025-11-01 16:22:46,772 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-11-01 16:23:03,785 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:10003/1
2025-11-01 16:23:03,789 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/15869
2025-11-01 16:23:03,790 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/19848
2025-11-01 16:23:03,791 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/13171
2025-11-01 16:23:03,791 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/10003
2025-11-01 16:23:03,791 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/29543
