2025-12-09 12:52:59,013 - INFO - ya.test.1986723  - pytest_runtest_setup: ####################################################################################################
2025-12-09 12:52:59,013 - INFO - ya.test.1986723  - pytest_runtest_setup: test_all_supported_compression[zstd_13_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 13]
2025-12-09 12:52:59,014 - INFO - ya.test.1986723  - pytest_runtest_setup: ####################################################################################################
2025-12-09 12:52:59,014 - INFO - ya.test.1986723  - pytest_runtest_setup: Test setup
2025-12-09 12:52:59,016 - INFO - ya.test.1986723  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_13_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 13])
2025-12-09 12:52:59,017 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:52:59,017 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 14169aab-6d93-446e-b701-c541955b561f, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:52:59,018 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 14169aab-6d93-446e-b701-c541955b561f, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_13_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 13)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:52:59,020 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 14169aab-6d93-446e-b701-c541955b561f, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:02,007 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:02,008 - INFO - __tests__.alter_compression.1986723  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_13_compression created
2025-12-09 12:53:02,008 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:02,009 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 0eda19ec-2304-4ee7-919a-283b4ec43ebb, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:02,010 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 0eda19ec-2304-4ee7-919a-283b4ec43ebb, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_13_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:02,017 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 0eda19ec-2304-4ee7-919a-283b4ec43ebb, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:03,061 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:03,062 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:03,063 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 3265d9f2-e9f0-4315-9283-35cc7a13eaaa, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:03,064 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 3265d9f2-e9f0-4315-9283-35cc7a13eaaa, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:03,066 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 3265d9f2-e9f0-4315-9283-35cc7a13eaaa, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:06,867 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:06,868 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:06,868 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 7ec9f281-6535-434b-8b2e-f183422cf9ff, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:06,869 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 7ec9f281-6535-434b-8b2e-f183422cf9ff, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:06,871 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 7ec9f281-6535-434b-8b2e-f183422cf9ff, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:07,718 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:07,719 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:07,720 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 138e0088-9c38-4a81-86d2-252d77040949, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:07,721 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 138e0088-9c38-4a81-86d2-252d77040949, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:07,727 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 138e0088-9c38-4a81-86d2-252d77040949, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:09,940 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:09,941 - INFO - __tests__.alter_compression.1986723  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_13_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318544, 'BlobCount': 128}}
2025-12-09 12:53:09,942 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:09,943 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 62f65a72-5e44-4173-971b-a16582ac3d36, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:09,944 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 62f65a72-5e44-4173-971b-a16582ac3d36, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:09,946 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 62f65a72-5e44-4173-971b-a16582ac3d36, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:13,163 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:13,164 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:13,164 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 4e926d3c-5e8c-4b90-b693-f3f6048c577e, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:13,165 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 4e926d3c-5e8c-4b90-b693-f3f6048c577e, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:13,166 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 4e926d3c-5e8c-4b90-b693-f3f6048c577e, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:13,459 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:13,459 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:13,460 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 1f41a86b-9148-49df-97bc-bd8001804610, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:13,461 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 1f41a86b-9148-49df-97bc-bd8001804610, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:13,463 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 1f41a86b-9148-49df-97bc-bd8001804610, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:13,831 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:13,832 - INFO - __tests__.alter_compression.1986723  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_13_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 638064, 'BlobCount': 256}}
2025-12-09 12:53:13,832 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:13,833 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, f0f11873-7c9b-4755-ac28-251c4e99873a, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:13,834 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, f0f11873-7c9b-4755-ac28-251c4e99873a, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:13,835 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, f0f11873-7c9b-4755-ac28-251c4e99873a, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:17,702 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:17,702 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:17,703 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 0e755c21-1ae4-4652-a369-faaf43a65996, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:17,704 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 0e755c21-1ae4-4652-a369-faaf43a65996, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:17,708 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 0e755c21-1ae4-4652-a369-faaf43a65996, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:18,133 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:18,134 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:18,135 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 9a7de790-3b6d-4c1f-8532-2dca0485fab2, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:18,136 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 9a7de790-3b6d-4c1f-8532-2dca0485fab2, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:18,138 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 9a7de790-3b6d-4c1f-8532-2dca0485fab2, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:19,096 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:19,097 - INFO - __tests__.alter_compression.1986723  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_13_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 957088, 'BlobCount': 384}}
2025-12-09 12:53:19,098 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:19,099 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 07189611-58cf-4982-975d-39baa352d2b0, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:19,100 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 07189611-58cf-4982-975d-39baa352d2b0, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:19,121 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 07189611-58cf-4982-975d-39baa352d2b0, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:22,591 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:22,592 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:22,593 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 7f1bcca5-d3a3-4f6f-adf3-828e786403d4, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:22,593 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 7f1bcca5-d3a3-4f6f-adf3-828e786403d4, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:22,595 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 7f1bcca5-d3a3-4f6f-adf3-828e786403d4, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:23,026 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:23,027 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:23,028 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 7a4ce61e-8386-44b4-92da-1f9f8c9fd4a5, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:23,029 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 7a4ce61e-8386-44b4-92da-1f9f8c9fd4a5, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:23,030 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 7a4ce61e-8386-44b4-92da-1f9f8c9fd4a5, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:23,646 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:23,647 - INFO - __tests__.alter_compression.1986723  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_13_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1276560, 'BlobCount': 512}}
2025-12-09 12:53:23,648 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:23,648 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 62476209-7bd2-4009-bc20-7d6b08a09304, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:23,658 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 62476209-7bd2-4009-bc20-7d6b08a09304, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:23,660 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 62476209-7bd2-4009-bc20-7d6b08a09304, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:27,169 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:27,170 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:27,170 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 9e00bd9d-42e8-4e6f-87b1-984817efd49c, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:27,171 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 9e00bd9d-42e8-4e6f-87b1-984817efd49c, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:27,172 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 9e00bd9d-42e8-4e6f-87b1-984817efd49c, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:27,589 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:27,590 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:27,591 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, d2e04195-849c-407e-81dc-54b3f1e0131f, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:27,592 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, d2e04195-849c-407e-81dc-54b3f1e0131f, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:27,594 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, d2e04195-849c-407e-81dc-54b3f1e0131f, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:28,419 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:28,420 - INFO - __tests__.alter_compression.1986723  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_13_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1595584, 'BlobCount': 640}}
2025-12-09 12:53:28,421 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:28,422 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, fc062980-2dca-477b-89d4-ac46923f1967, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:28,423 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, fc062980-2dca-477b-89d4-ac46923f1967, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:28,434 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, fc062980-2dca-477b-89d4-ac46923f1967, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:31,658 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:31,659 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:31,660 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 8dbdda33-b642-4172-9ee6-814d422cee49, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:31,661 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 8dbdda33-b642-4172-9ee6-814d422cee49, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:31,663 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 8dbdda33-b642-4172-9ee6-814d422cee49, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:32,115 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:32,116 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:32,117 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 72650ae8-81de-4ba7-8fcf-c9d327b435c6, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:32,118 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 72650ae8-81de-4ba7-8fcf-c9d327b435c6, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:32,128 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 72650ae8-81de-4ba7-8fcf-c9d327b435c6, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:32,858 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:32,859 - INFO - __tests__.alter_compression.1986723  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_13_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1914960, 'BlobCount': 768}}
2025-12-09 12:53:32,860 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:32,860 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 56052902-b3d0-44bd-8af6-68a09c61d23c, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:32,865 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 56052902-b3d0-44bd-8af6-68a09c61d23c, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:32,867 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 56052902-b3d0-44bd-8af6-68a09c61d23c, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:36,084 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:36,085 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:36,085 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 76653501-51e3-4584-9213-9d78352a3764, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:36,086 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 76653501-51e3-4584-9213-9d78352a3764, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:36,087 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 76653501-51e3-4584-9213-9d78352a3764, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:36,333 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:36,334 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:36,334 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, def465a4-95c0-4339-8b3a-b09e83b3c00f, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:36,335 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, def465a4-95c0-4339-8b3a-b09e83b3c00f, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:36,336 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, def465a4-95c0-4339-8b3a-b09e83b3c00f, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:36,994 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:36,995 - INFO - __tests__.alter_compression.1986723  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_13_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2234080, 'BlobCount': 896}}
2025-12-09 12:53:36,995 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:36,996 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, d24cf206-3bc7-42a9-8e7a-22f6cc03b2c2, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:36,997 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, d24cf206-3bc7-42a9-8e7a-22f6cc03b2c2, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:36,998 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, d24cf206-3bc7-42a9-8e7a-22f6cc03b2c2, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:39,307 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:39,308 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:39,309 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, eaf000b8-8180-4258-a88d-909b1c420ef4, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:39,309 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, eaf000b8-8180-4258-a88d-909b1c420ef4, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:39,311 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, eaf000b8-8180-4258-a88d-909b1c420ef4, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:39,580 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:39,581 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:39,582 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, a83c97a7-dee2-4517-884b-a91a941e42aa, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:39,583 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, a83c97a7-dee2-4517-884b-a91a941e42aa, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:39,584 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, a83c97a7-dee2-4517-884b-a91a941e42aa, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:40,236 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:40,237 - INFO - __tests__.alter_compression.1986723  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_13_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2553696, 'BlobCount': 1024}}
2025-12-09 12:53:40,238 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:40,239 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, bcac4042-e7a5-4be7-8b6b-7d1dba15c6ad, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:40,240 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, bcac4042-e7a5-4be7-8b6b-7d1dba15c6ad, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:40,250 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, bcac4042-e7a5-4be7-8b6b-7d1dba15c6ad, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:43,126 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:43,127 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:43,128 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, ee09a47e-2902-4d7f-9cd8-21aa504730e8, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:43,128 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, ee09a47e-2902-4d7f-9cd8-21aa504730e8, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:43,130 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, ee09a47e-2902-4d7f-9cd8-21aa504730e8, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:43,580 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:43,581 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:43,582 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, babf8e48-c73c-4466-a0f9-9bbea0ad6f36, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:43,583 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, babf8e48-c73c-4466-a0f9-9bbea0ad6f36, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:43,586 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, babf8e48-c73c-4466-a0f9-9bbea0ad6f36, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:44,223 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:44,224 - INFO - __tests__.alter_compression.1986723  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_13_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2872720, 'BlobCount': 1152}}
2025-12-09 12:53:44,225 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:44,225 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, d9eb9ab5-5c3c-407c-8b02-ac1b5e6d48e6, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:44,227 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, d9eb9ab5-5c3c-407c-8b02-ac1b5e6d48e6, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:44,229 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, d9eb9ab5-5c3c-407c-8b02-ac1b5e6d48e6, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:46,866 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:46,867 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:46,867 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, c386ce91-0826-4f54-b491-6fb43b19ab1f, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:46,868 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, c386ce91-0826-4f54-b491-6fb43b19ab1f, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:46,870 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, c386ce91-0826-4f54-b491-6fb43b19ab1f, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:47,295 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:47,296 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:47,296 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 48064f08-d8af-4b55-94d6-c75ec2a53800, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:47,298 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 48064f08-d8af-4b55-94d6-c75ec2a53800, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:47,299 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 48064f08-d8af-4b55-94d6-c75ec2a53800, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:48,017 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:48,018 - INFO - __tests__.alter_compression.1986723  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_13_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3192432, 'BlobCount': 1280}}
2025-12-09 12:53:48,019 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:48,019 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, ec02f493-60d1-453f-b063-4eee0eaf45a2, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:48,020 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, ec02f493-60d1-453f-b063-4eee0eaf45a2, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_13_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:48,022 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, ec02f493-60d1-453f-b063-4eee0eaf45a2, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:49,066 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:49,067 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:49,068 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 57cd889d-8e71-4be5-bb0b-92db8d822443, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:49,072 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 57cd889d-8e71-4be5-bb0b-92db8d822443, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:49,074 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 57cd889d-8e71-4be5-bb0b-92db8d822443, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:49,353 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:49,353 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:49,354 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 478db04d-210f-4b92-8994-22b94fa5c39d, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:49,355 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 478db04d-210f-4b92-8994-22b94fa5c39d, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:49,356 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 478db04d-210f-4b92-8994-22b94fa5c39d, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:49,559 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:49,560 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:53:49,560 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, cdd3ce15-da6c-4761-810a-2aa37df83814, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:53:49,561 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, cdd3ce15-da6c-4761-810a-2aa37df83814, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_13_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:53:49,563 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, cdd3ce15-da6c-4761-810a-2aa37df83814, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:53:52,835 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:54:02,876 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:54:02,877 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, e3a67992-b5c6-4379-9aa4-0ded5cbda29d, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:54:02,878 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, e3a67992-b5c6-4379-9aa4-0ded5cbda29d, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_13_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:54:02,879 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, e3a67992-b5c6-4379-9aa4-0ded5cbda29d, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:54:05,546 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:54:15,596 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:54:15,597 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, ed1f77e5-fc1c-4b35-8dee-6358fc7a718a, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:54:15,598 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, ed1f77e5-fc1c-4b35-8dee-6358fc7a718a, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_13_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:54:15,599 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, ed1f77e5-fc1c-4b35-8dee-6358fc7a718a, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:54:16,202 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:54:26,210 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:54:26,211 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, e24e0ef5-734f-4098-aa22-96ba39277878, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:54:26,212 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, e24e0ef5-734f-4098-aa22-96ba39277878, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_13_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:54:26,213 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, e24e0ef5-734f-4098-aa22-96ba39277878, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:54:26,903 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:54:26,907 - INFO - root.1986723  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_13_compression`, volumes `value` (8000000, 1870856)
2025-12-09 12:54:26,908 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:54:26,909 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 4f677ec9-e8c4-47f0-936d-82704ce9a531, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:54:26,912 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 4f677ec9-e8c4-47f0-936d-82704ce9a531, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_13_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:54:26,914 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 4f677ec9-e8c4-47f0-936d-82704ce9a531, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:54:27,305 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:54:27,305 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:54:27,306 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 4a6295e8-5342-4215-85a0-9e5fcf644d15, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:54:27,307 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 4a6295e8-5342-4215-85a0-9e5fcf644d15, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_13_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:54:27,308 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 4a6295e8-5342-4215-85a0-9e5fcf644d15, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:54:27,952 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:54:37,957 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:54:37,958 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 6997a95e-940d-4086-b345-52cfd6a5c0b1, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:54:37,959 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 6997a95e-940d-4086-b345-52cfd6a5c0b1, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_13_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:54:37,960 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 6997a95e-940d-4086-b345-52cfd6a5c0b1, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:54:39,420 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:54:39,425 - INFO - root.1986723  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_13_compression`, volumes `value` (8000000, 1870856)
2025-12-09 12:54:39,426 - INFO - root.1986723  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_13_compression` 8092160 / 1870856: 4.325378329491954
2025-12-09 12:54:39,446 - INFO - ya.test.1986723  - pytest_runtest_teardown: Test teardown
