2025-12-04 20:32:58,553 - INFO - ya.test.37924  - pytest_runtest_setup: ####################################################################################################
2025-12-04 20:32:58,560 - INFO - ya.test.37924  - pytest_runtest_setup: test_all_supported_compression[zstd_10_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 10]
2025-12-04 20:32:58,561 - INFO - ya.test.37924  - pytest_runtest_setup: ####################################################################################################
2025-12-04 20:32:58,561 - INFO - ya.test.37924  - pytest_runtest_setup: Test setup
2025-12-04 20:32:58,567 - INFO - ya.test.37924  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_10_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 10])
2025-12-04 20:32:58,568 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:32:58,569 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, 699a2877-301a-49c5-aa18-faf06dc0c254, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:32:58,570 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, 699a2877-301a-49c5-aa18-faf06dc0c254, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_10_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 10)\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-04 20:32:58,576 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, 699a2877-301a-49c5-aa18-faf06dc0c254, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:03,785 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:03,786 - INFO - __tests__.alter_compression.37924  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_10_compression created
2025-12-04 20:33:03,786 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:03,787 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, 8c76f80c-3193-4587-b55a-8e966b29cd60, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:03,788 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, 8c76f80c-3193-4587-b55a-8e966b29cd60, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_10_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 20:33:03,791 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, 8c76f80c-3193-4587-b55a-8e966b29cd60, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:06,146 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:06,146 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:06,147 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, ea4d5e00-6e66-47e3-b04c-550d06df5d28, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:06,148 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, ea4d5e00-6e66-47e3-b04c-550d06df5d28, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:06,149 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, ea4d5e00-6e66-47e3-b04c-550d06df5d28, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:09,668 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:09,668 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:09,669 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, 69749c28-b12f-4f07-8db1-fc9f2e3dead4, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:09,670 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, 69749c28-b12f-4f07-8db1-fc9f2e3dead4, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:09,671 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, 69749c28-b12f-4f07-8db1-fc9f2e3dead4, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:10,780 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:10,781 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:10,781 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, b2c75aaf-feeb-4f1f-b519-369181c8055e, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:10,782 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, b2c75aaf-feeb-4f1f-b519-369181c8055e, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:10,784 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, b2c75aaf-feeb-4f1f-b519-369181c8055e, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:13,613 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:13,614 - INFO - __tests__.alter_compression.37924  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_10_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318048, 'BlobCount': 128}}
2025-12-04 20:33:13,615 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:13,615 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, e2327717-5d3a-4d35-8a13-9826236a81ea, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:13,616 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, e2327717-5d3a-4d35-8a13-9826236a81ea, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:13,624 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, e2327717-5d3a-4d35-8a13-9826236a81ea, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:16,646 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.37924  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 20:33:16,646 - DEBUG - ydb.connection.37924  - 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-12-04 20:33:16,678 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.37924  - context_resolve: Resolving endpoints for database /Root
2025-12-04 20:33:16,679 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ListEndpoints, 7f128424-b29a-474a-9492-7a3afd66d61f, localhost:18720): creating call state
2025-12-04 20:33:16,680 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ListEndpoints, 7f128424-b29a-474a-9492-7a3afd66d61f, localhost:18720): request = { database: "/Root" }
2025-12-04 20:33:16,692 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ListEndpoints, 7f128424-b29a-474a-9492-7a3afd66d61f, localhost:18720): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-fryxcz52gi.auto.internal" port: 18720 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-12-04 20:33:16,693 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.37924  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-fryxcz52gi.auto.internal:18720, location 1, ssl: False>]>
2025-12-04 20:33:16,693 - DEBUG - ydb.connection.37924  - close: Closing channel for endpoint localhost:18720
2025-12-04 20:33:17,213 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:17,214 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:17,214 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, 124260b1-1504-4e35-8bd7-31f21e183760, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:17,215 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, 124260b1-1504-4e35-8bd7-31f21e183760, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:17,217 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, 124260b1-1504-4e35-8bd7-31f21e183760, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:17,505 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:17,505 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:17,506 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, 5a0ca8ef-476a-4df3-8ebc-564f55b11e8e, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:17,507 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, 5a0ca8ef-476a-4df3-8ebc-564f55b11e8e, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:17,509 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, 5a0ca8ef-476a-4df3-8ebc-564f55b11e8e, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:17,880 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:17,881 - INFO - __tests__.alter_compression.37924  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_10_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 637344, 'BlobCount': 256}}
2025-12-04 20:33:17,881 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:17,882 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, b2e3ce20-41e8-46e5-b8af-8ef9b2a4db37, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:17,883 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, b2e3ce20-41e8-46e5-b8af-8ef9b2a4db37, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:17,884 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, b2e3ce20-41e8-46e5-b8af-8ef9b2a4db37, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:19,677 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:19,677 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:19,678 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, 30d447a5-550e-4f41-b265-f5eb77bf60a5, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:19,679 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, 30d447a5-550e-4f41-b265-f5eb77bf60a5, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:19,681 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, 30d447a5-550e-4f41-b265-f5eb77bf60a5, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:20,073 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:20,101 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:20,102 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, 246789ab-40fd-4918-b472-55b12540bde7, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:20,103 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, 246789ab-40fd-4918-b472-55b12540bde7, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:20,104 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, 246789ab-40fd-4918-b472-55b12540bde7, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:20,532 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:20,533 - INFO - __tests__.alter_compression.37924  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_10_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 956384, 'BlobCount': 384}}
2025-12-04 20:33:20,533 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:20,534 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, 80f94459-3667-4e76-bb3d-63ca49784a81, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:20,535 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, 80f94459-3667-4e76-bb3d-63ca49784a81, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:20,536 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, 80f94459-3667-4e76-bb3d-63ca49784a81, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:22,677 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:22,678 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:22,678 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, 4614b6c7-9021-4f75-90be-cd149f5ab120, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:22,679 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, 4614b6c7-9021-4f75-90be-cd149f5ab120, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:22,684 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, 4614b6c7-9021-4f75-90be-cd149f5ab120, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:23,172 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:23,173 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:23,174 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, ef195a80-fc5d-435b-bfb3-8b30385fb9c1, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:23,175 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, ef195a80-fc5d-435b-bfb3-8b30385fb9c1, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:23,177 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, ef195a80-fc5d-435b-bfb3-8b30385fb9c1, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:23,828 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:23,829 - INFO - __tests__.alter_compression.37924  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_10_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1275744, 'BlobCount': 512}}
2025-12-04 20:33:23,829 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:23,830 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, 458212d9-b205-400e-bdcd-1dc3fdf7f202, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:23,831 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, 458212d9-b205-400e-bdcd-1dc3fdf7f202, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:23,833 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, 458212d9-b205-400e-bdcd-1dc3fdf7f202, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:25,608 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:25,608 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:25,609 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, c1d95f00-ec09-428d-8371-454e8df4adb0, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:25,610 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, c1d95f00-ec09-428d-8371-454e8df4adb0, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:25,612 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, c1d95f00-ec09-428d-8371-454e8df4adb0, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:26,019 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:26,020 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:26,020 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, aea27295-d571-441e-96fe-0bc48baf6119, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:26,021 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, aea27295-d571-441e-96fe-0bc48baf6119, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:26,023 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, aea27295-d571-441e-96fe-0bc48baf6119, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:27,086 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:27,087 - INFO - __tests__.alter_compression.37924  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_10_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1594704, 'BlobCount': 640}}
2025-12-04 20:33:27,088 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:27,088 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, ff6384c5-50af-4953-9bc1-d358c39a3a04, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:27,089 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, ff6384c5-50af-4953-9bc1-d358c39a3a04, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:27,091 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, ff6384c5-50af-4953-9bc1-d358c39a3a04, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:29,037 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:29,038 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:29,038 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, 96969bc1-b3ce-4f0d-b6a3-09421812b460, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:29,039 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, 96969bc1-b3ce-4f0d-b6a3-09421812b460, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:29,041 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, 96969bc1-b3ce-4f0d-b6a3-09421812b460, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:29,605 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:29,606 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:29,607 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, 7a58c63e-fd38-4e75-ba94-26dcc069b0ad, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:29,608 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, 7a58c63e-fd38-4e75-ba94-26dcc069b0ad, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:29,609 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, 7a58c63e-fd38-4e75-ba94-26dcc069b0ad, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:30,232 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:30,233 - INFO - __tests__.alter_compression.37924  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_10_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1913888, 'BlobCount': 768}}
2025-12-04 20:33:30,233 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:30,234 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, a60350f1-1779-4537-9a27-10f8eb789241, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:30,235 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, a60350f1-1779-4537-9a27-10f8eb789241, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:30,241 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, a60350f1-1779-4537-9a27-10f8eb789241, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:32,645 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:32,646 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:32,647 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, 6065b43c-b9cc-4eb6-b8c9-789a3c3505bc, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:32,648 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, 6065b43c-b9cc-4eb6-b8c9-789a3c3505bc, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:32,650 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, 6065b43c-b9cc-4eb6-b8c9-789a3c3505bc, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:33,114 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:33,115 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:33,116 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, 2be0f8b1-3dd5-4320-ab6c-44829624ad6b, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:33,117 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, 2be0f8b1-3dd5-4320-ab6c-44829624ad6b, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:33,118 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, 2be0f8b1-3dd5-4320-ab6c-44829624ad6b, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:33,801 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:33,802 - INFO - __tests__.alter_compression.37924  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_10_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2233024, 'BlobCount': 896}}
2025-12-04 20:33:33,802 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:33,803 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, 47a93d85-7db2-436c-a639-585274b0aa35, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:33,804 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, 47a93d85-7db2-436c-a639-585274b0aa35, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:33,808 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, 47a93d85-7db2-436c-a639-585274b0aa35, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:35,689 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:35,690 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:35,690 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, 871bbc2b-1483-4f10-a0dd-337e8d440e63, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:35,691 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, 871bbc2b-1483-4f10-a0dd-337e8d440e63, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:35,693 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, 871bbc2b-1483-4f10-a0dd-337e8d440e63, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:36,068 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:36,069 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:36,070 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, 0bd25a76-51d9-417b-a07d-0e0cc44ec8d0, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:36,071 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, 0bd25a76-51d9-417b-a07d-0e0cc44ec8d0, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:36,072 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, 0bd25a76-51d9-417b-a07d-0e0cc44ec8d0, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:36,786 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:36,787 - INFO - __tests__.alter_compression.37924  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_10_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2552512, 'BlobCount': 1024}}
2025-12-04 20:33:36,788 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:36,788 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, 93e000cd-1c1b-4c78-8d15-95918850620e, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:36,789 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, 93e000cd-1c1b-4c78-8d15-95918850620e, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:36,795 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, 93e000cd-1c1b-4c78-8d15-95918850620e, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:38,448 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:38,449 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:38,450 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, cf2c5c6c-1912-4477-9422-f4c6be1dd675, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:38,451 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, cf2c5c6c-1912-4477-9422-f4c6be1dd675, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:38,453 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, cf2c5c6c-1912-4477-9422-f4c6be1dd675, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:38,726 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:38,727 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:38,728 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, a6fe79e8-e8bf-4455-87f2-2d93510053d2, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:38,729 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, a6fe79e8-e8bf-4455-87f2-2d93510053d2, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:38,730 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, a6fe79e8-e8bf-4455-87f2-2d93510053d2, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:39,355 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:39,356 - INFO - __tests__.alter_compression.37924  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_10_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2871520, 'BlobCount': 1152}}
2025-12-04 20:33:39,357 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:39,358 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, 562a7455-37c7-459a-9bc2-88959aafa3b2, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:39,359 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, 562a7455-37c7-459a-9bc2-88959aafa3b2, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:39,361 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, 562a7455-37c7-459a-9bc2-88959aafa3b2, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:40,855 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:40,856 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:40,857 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, 6f680d81-8e14-4f64-ba77-c397b2c179c2, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:40,857 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, 6f680d81-8e14-4f64-ba77-c397b2c179c2, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:40,859 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, 6f680d81-8e14-4f64-ba77-c397b2c179c2, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:41,138 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:41,139 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:41,168 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, 0b18efa9-e5f4-4e79-bb00-1bd7a35fa0b7, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:41,168 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, 0b18efa9-e5f4-4e79-bb00-1bd7a35fa0b7, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:41,169 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, 0b18efa9-e5f4-4e79-bb00-1bd7a35fa0b7, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:41,839 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:41,840 - INFO - __tests__.alter_compression.37924  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_10_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3191024, 'BlobCount': 1280}}
2025-12-04 20:33:41,841 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:41,841 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, 2a5454ba-21be-4650-b1d4-c09a1a99b441, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:41,842 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, 2a5454ba-21be-4650-b1d4-c09a1a99b441, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_10_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 20:33:41,851 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, 2a5454ba-21be-4650-b1d4-c09a1a99b441, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:42,918 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:42,918 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:42,919 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, 721263ae-2ffd-42e5-8439-3f67e4cd23dd, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:42,920 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, 721263ae-2ffd-42e5-8439-3f67e4cd23dd, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:42,921 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, 721263ae-2ffd-42e5-8439-3f67e4cd23dd, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:43,232 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:43,233 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:43,233 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, 27f3aa2d-38df-46fc-86cf-1451c63f87cb, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:43,234 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, 27f3aa2d-38df-46fc-86cf-1451c63f87cb, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:33:43,236 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, 27f3aa2d-38df-46fc-86cf-1451c63f87cb, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:43,667 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:43,668 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:43,668 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, 0d4f365b-fea1-4349-b000-f2b200a819d0, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:43,669 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, 0d4f365b-fea1-4349-b000-f2b200a819d0, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_10_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-04 20:33:43,671 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, 0d4f365b-fea1-4349-b000-f2b200a819d0, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:33:47,747 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:57,800 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:33:57,801 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, eab9a88b-84cb-476d-ad5c-3898c177401d, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:33:57,801 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, eab9a88b-84cb-476d-ad5c-3898c177401d, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_10_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-04 20:33:57,803 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, eab9a88b-84cb-476d-ad5c-3898c177401d, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:34:01,241 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:34:01,286 - INFO - root.37924  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_10_compression`, volumes `value` (8000000, 1595512)
2025-12-04 20:34:01,287 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:34:01,287 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, 025cebc3-1afa-4288-aa55-090ff6071539, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:34:01,288 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, 025cebc3-1afa-4288-aa55-090ff6071539, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" 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_10_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-04 20:34:01,289 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, 025cebc3-1afa-4288-aa55-090ff6071539, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:34:01,606 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:34:01,663 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:34:01,664 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, 2f59cd2c-c7f1-4df3-8b91-66a257c9ef8d, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:34:01,665 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, 2f59cd2c-c7f1-4df3-8b91-66a257c9ef8d, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_10_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-04 20:34:01,666 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, 2f59cd2c-c7f1-4df3-8b91-66a257c9ef8d, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:34:05,621 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:34:15,660 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:34:15,661 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, 2c4490d3-816d-48a0-9074-2e8a45af874d, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:34:15,662 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, 2c4490d3-816d-48a0-9074-2e8a45af874d, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_10_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-04 20:34:15,663 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, 2c4490d3-816d-48a0-9074-2e8a45af874d, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:34:16,659 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:34:18,612 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.37924  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 20:34:18,612 - DEBUG - ydb.connection.37924  - 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-12-04 20:34:18,628 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.37924  - context_resolve: Resolving endpoints for database /Root
2025-12-04 20:34:18,628 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ListEndpoints, 828ed370-4b58-434c-82ad-b2ffc861ab07, localhost:18720): creating call state
2025-12-04 20:34:18,629 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ListEndpoints, 828ed370-4b58-434c-82ad-b2ffc861ab07, localhost:18720): request = { database: "/Root" }
2025-12-04 20:34:18,634 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ListEndpoints, 828ed370-4b58-434c-82ad-b2ffc861ab07, localhost:18720): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-fryxcz52gi.auto.internal" port: 18720 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-12-04 20:34:18,635 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.37924  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-fryxcz52gi.auto.internal:18720, location 1, ssl: False>]>
2025-12-04 20:34:18,636 - DEBUG - ydb.connection.37924  - close: Closing channel for endpoint localhost:18720
2025-12-04 20:34:26,664 - DEBUG - ydb.query.pool.37924  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:34:26,665 - DEBUG - ydb.connection.37924  - _prepare_call: RpcState(ExecuteQuery, c311d258-834a-425e-9cea-3883e0209981, ghrun-fryxcz52gi.auto.internal:18720): creating call state
2025-12-04 20:34:26,665 - DEBUG - ydb.connection.37924  - _log_request: RpcState(ExecuteQuery, c311d258-834a-425e-9cea-3883e0209981, ghrun-fryxcz52gi.auto.internal:18720): request = { session_id: "ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_10_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-04 20:34:26,667 - DEBUG - ydb.connection.37924  - _log_response: RpcState(ExecuteQuery, c311d258-834a-425e-9cea-3883e0209981, ghrun-fryxcz52gi.auto.internal:18720): response = { <_MultiThreadedRendezvous object> }
2025-12-04 20:34:27,799 - DEBUG - ydb.query.pool.37924  - release: Session returned to queue: ydb://session/3?node_id=1&id=OWI1NjRhYTEtMjYxMzY2ZTItZjNjZDc4ODQtZDdkZTRhOGQ=
2025-12-04 20:34:27,803 - INFO - root.37924  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_10_compression`, volumes `value` (8000000, 1465240)
2025-12-04 20:34:27,803 - INFO - root.37924  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_10_compression` 8092160 / 1465240: 5.522753951571073
2025-12-04 20:34:27,870 - INFO - ya.test.37924  - pytest_runtest_teardown: Test teardown
