2025-10-15 15:15:08,482 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-15 15:15:08,482 - INFO - ya.test - pytest_runtest_setup: test_all_supported_compression[zstd_16_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 16]
2025-10-15 15:15:08,482 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-15 15:15:08,483 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-15 15:15:08,485 - INFO - ya.test - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_16_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 16])
2025-10-15 15:15:08,486 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:08,487 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3396ed5b-2e3c-4d47-9674-8671cce8ede9, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:15:08,488 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3396ed5b-2e3c-4d47-9674-8671cce8ede9, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_16_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 16)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:15:08,489 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3396ed5b-2e3c-4d47-9674-8671cce8ede9, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:15:12,657 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:12,658 - INFO - __tests__.alter_compression - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_16_compression created
2025-10-15 15:15:12,658 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:12,659 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 48b59955-dc37-4839-b550-f74fd1e137bc, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:15:12,660 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 48b59955-dc37-4839-b550-f74fd1e137bc, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_16_compression`" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:15:12,661 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 48b59955-dc37-4839-b550-f74fd1e137bc, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:15:14,680 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:14,681 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:14,682 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 57170bc4-9e54-4781-b4d8-50288b0eb680, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:15:14,683 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 57170bc4-9e54-4781-b4d8-50288b0eb680, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 0;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_16_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:15:14,685 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 57170bc4-9e54-4781-b4d8-50288b0eb680, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:15:21,071 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:21,072 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:21,073 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, dcc9dfb3-f345-4e3a-b9e6-5beb4c623c64, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:15:21,074 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, dcc9dfb3-f345-4e3a-b9e6-5beb4c623c64, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_16_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:15:21,075 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, dcc9dfb3-f345-4e3a-b9e6-5beb4c623c64, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:15:22,297 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:22,298 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:22,299 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 02eb2115-355e-4617-b919-df1798797bd7, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:15:22,300 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 02eb2115-355e-4617-b919-df1798797bd7, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_16_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:15:22,302 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 02eb2115-355e-4617-b919-df1798797bd7, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:15:24,427 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:24,428 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_16_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318528, 'BlobCount': 128}}
2025-10-15 15:15:24,428 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:24,429 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5eb89d54-df4b-4b10-b5b1-6446645088a7, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:15:24,430 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5eb89d54-df4b-4b10-b5b1-6446645088a7, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 100000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_16_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:15:24,432 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5eb89d54-df4b-4b10-b5b1-6446645088a7, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:15:29,414 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:29,415 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:29,415 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 19e61273-4e24-4db7-aa2a-ea0c73d3be4a, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:15:29,416 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 19e61273-4e24-4db7-aa2a-ea0c73d3be4a, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_16_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:15:29,417 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 19e61273-4e24-4db7-aa2a-ea0c73d3be4a, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:15:29,745 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:29,746 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:29,747 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 97792c0d-0025-4b5e-9950-641ca0b515f3, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:15:29,748 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 97792c0d-0025-4b5e-9950-641ca0b515f3, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_16_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:15:29,749 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 97792c0d-0025-4b5e-9950-641ca0b515f3, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:15:30,227 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:30,229 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_16_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 637920, 'BlobCount': 256}}
2025-10-15 15:15:30,229 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:30,230 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d341639a-5bd2-4ee9-b5d7-f99f857aeecc, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:15:30,231 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d341639a-5bd2-4ee9-b5d7-f99f857aeecc, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 200000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_16_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:15:30,238 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d341639a-5bd2-4ee9-b5d7-f99f857aeecc, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:15:35,727 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:35,728 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:35,728 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 71f1376c-a7d5-4fca-9f81-25c01ae1514a, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:15:35,729 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 71f1376c-a7d5-4fca-9f81-25c01ae1514a, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_16_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:15:35,733 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 71f1376c-a7d5-4fca-9f81-25c01ae1514a, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:15:36,076 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:36,077 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:36,078 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ded5a188-4292-4de4-999a-dfdd7466622d, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:15:36,078 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ded5a188-4292-4de4-999a-dfdd7466622d, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_16_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:15:36,080 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ded5a188-4292-4de4-999a-dfdd7466622d, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:15:36,471 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:36,472 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_16_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 173}}, blobs: {'__DEFAULT': {'Portions': 173, 'BlobSize': 962392, 'BlobCount': 384}}
2025-10-15 15:15:36,472 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:36,473 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5174a970-8322-44e3-966c-a408fb0ecf7f, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:15:36,474 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5174a970-8322-44e3-966c-a408fb0ecf7f, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 300000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_16_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:15:36,485 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5174a970-8322-44e3-966c-a408fb0ecf7f, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:15:41,154 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:41,155 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:41,156 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c77d4b25-d5c7-4e00-a3a7-a15947dd1673, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:15:41,156 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c77d4b25-d5c7-4e00-a3a7-a15947dd1673, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_16_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:15:41,158 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c77d4b25-d5c7-4e00-a3a7-a15947dd1673, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:15:41,453 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:41,454 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:41,455 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 48ec6d54-3b1c-4199-a4b2-b80c746040f5, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:15:41,456 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 48ec6d54-3b1c-4199-a4b2-b80c746040f5, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_16_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:15:41,461 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 48ec6d54-3b1c-4199-a4b2-b80c746040f5, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:15:41,953 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:41,954 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_16_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 225}}, blobs: {'__DEFAULT': {'Portions': 225, 'BlobSize': 1280784, 'BlobCount': 500}}
2025-10-15 15:15:41,955 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:41,956 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c67fe4c4-6066-4256-b7d1-2ddfff2f7758, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:15:41,957 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c67fe4c4-6066-4256-b7d1-2ddfff2f7758, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 400000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_16_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:15:41,959 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c67fe4c4-6066-4256-b7d1-2ddfff2f7758, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:15:47,828 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:47,829 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:47,830 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e48bbd5e-22f2-4f6a-8138-af26a2301472, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:15:47,831 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e48bbd5e-22f2-4f6a-8138-af26a2301472, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_16_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:15:47,832 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e48bbd5e-22f2-4f6a-8138-af26a2301472, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:15:48,186 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:48,187 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:48,188 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 34d23274-0048-44bd-9f0c-1722983e79a0, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:15:48,189 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 34d23274-0048-44bd-9f0c-1722983e79a0, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_16_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:15:48,190 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 34d23274-0048-44bd-9f0c-1722983e79a0, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:15:48,830 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:48,831 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_16_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 289}}, blobs: {'__DEFAULT': {'Portions': 289, 'BlobSize': 1599680, 'BlobCount': 628}}
2025-10-15 15:15:48,832 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:48,832 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e99c26f2-5e00-42be-9664-cbd45e4fd2e1, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:15:48,833 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e99c26f2-5e00-42be-9664-cbd45e4fd2e1, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 500000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_16_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:15:48,835 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e99c26f2-5e00-42be-9664-cbd45e4fd2e1, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:15:53,277 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:53,278 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:53,278 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b2927451-24ed-4523-82dd-684fb1fcb215, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:15:53,279 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b2927451-24ed-4523-82dd-684fb1fcb215, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_16_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:15:53,292 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b2927451-24ed-4523-82dd-684fb1fcb215, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:15:53,731 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:53,732 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:53,733 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b467e23f-8c24-450a-b789-4fb1b3769c8d, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:15:53,734 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b467e23f-8c24-450a-b789-4fb1b3769c8d, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_16_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:15:53,735 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b467e23f-8c24-450a-b789-4fb1b3769c8d, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:15:54,253 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:54,254 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_16_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 353}}, blobs: {'__DEFAULT': {'Portions': 353, 'BlobSize': 1918960, 'BlobCount': 756}}
2025-10-15 15:15:54,254 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:54,255 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 77344e73-077e-4e8c-a0ec-e494838817a0, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:15:54,256 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 77344e73-077e-4e8c-a0ec-e494838817a0, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 600000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_16_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:15:54,258 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 77344e73-077e-4e8c-a0ec-e494838817a0, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:15:58,687 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:58,687 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:58,688 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 737d142e-28e5-4cc3-9c50-56dec5d19799, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:15:58,689 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 737d142e-28e5-4cc3-9c50-56dec5d19799, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_16_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:15:58,690 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 737d142e-28e5-4cc3-9c50-56dec5d19799, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:15:59,129 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:59,130 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:15:59,131 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d068626d-e155-481e-8977-98be15492570, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:15:59,132 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d068626d-e155-481e-8977-98be15492570, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_16_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:15:59,133 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d068626d-e155-481e-8977-98be15492570, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:16:00,215 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:00,215 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_16_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 398}}, blobs: {'__DEFAULT': {'Portions': 399, 'BlobSize': 2268128, 'BlobCount': 860}}
2025-10-15 15:16:00,216 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:00,217 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c50d888f-f7b0-4f41-b37b-cf8d35f9b814, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:16:00,218 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c50d888f-f7b0-4f41-b37b-cf8d35f9b814, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 700000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_16_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:16:00,219 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c50d888f-f7b0-4f41-b37b-cf8d35f9b814, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:16:04,883 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:04,884 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:04,885 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ead14d63-33ea-4d6c-acfe-c68323cea774, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:16:04,886 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ead14d63-33ea-4d6c-acfe-c68323cea774, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_16_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:16:04,887 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ead14d63-33ea-4d6c-acfe-c68323cea774, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:16:05,122 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:05,123 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:05,124 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 490e0c61-a18f-4ee4-b011-01d041df6d0f, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:16:05,125 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 490e0c61-a18f-4ee4-b011-01d041df6d0f, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_16_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:16:05,127 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 490e0c61-a18f-4ee4-b011-01d041df6d0f, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:16:05,685 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:05,686 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_16_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 2565720, 'BlobCount': 860}}
2025-10-15 15:16:05,686 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:05,687 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 361c2e0c-753d-49ae-ae3e-201c75f74841, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:16:05,688 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 361c2e0c-753d-49ae-ae3e-201c75f74841, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 800000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_16_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:16:05,690 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 361c2e0c-753d-49ae-ae3e-201c75f74841, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:16:09,822 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:09,823 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:09,823 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 60ce4357-a413-451c-a518-e9d0e234e0c2, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:16:09,824 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 60ce4357-a413-451c-a518-e9d0e234e0c2, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_16_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:16:09,827 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 60ce4357-a413-451c-a518-e9d0e234e0c2, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:16:10,092 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:10,093 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:10,094 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ea5b958e-0abc-4aa4-bc0e-340a2110ec12, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:16:10,095 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ea5b958e-0abc-4aa4-bc0e-340a2110ec12, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_16_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:16:10,096 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ea5b958e-0abc-4aa4-bc0e-340a2110ec12, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:16:10,763 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:10,764 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_16_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 413}}, blobs: {'__DEFAULT': {'Portions': 413, 'BlobSize': 2880320, 'BlobCount': 928}}
2025-10-15 15:16:10,764 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:10,765 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9a8db3ec-f96b-49c7-85c3-ff66c874bb8a, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:16:10,766 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9a8db3ec-f96b-49c7-85c3-ff66c874bb8a, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 900000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_16_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:16:10,769 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9a8db3ec-f96b-49c7-85c3-ff66c874bb8a, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:16:15,081 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:15,082 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:15,083 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d7c7ed1a-51cf-4a9a-9952-c620c571222b, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:16:15,084 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d7c7ed1a-51cf-4a9a-9952-c620c571222b, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_16_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:16:15,091 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d7c7ed1a-51cf-4a9a-9952-c620c571222b, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:16:15,296 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:15,297 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:15,297 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 89fff0e4-115a-4e94-b853-54909f635bc3, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:16:15,298 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 89fff0e4-115a-4e94-b853-54909f635bc3, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_16_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-15 15:16:15,301 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 89fff0e4-115a-4e94-b853-54909f635bc3, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:16:15,708 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:15,709 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_16_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 381}}, blobs: {'__DEFAULT': {'Portions': 381, 'BlobSize': 3185104, 'BlobCount': 888}}
2025-10-15 15:16:15,709 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:15,710 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c2332752-438a-448c-bc88-2a02caa5cae2, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:16:15,711 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c2332752-438a-448c-bc88-2a02caa5cae2, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_16_compression`" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:16:15,712 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c2332752-438a-448c-bc88-2a02caa5cae2, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:16:16,477 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:16,478 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:16,478 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 33e2db56-43f5-49f7-a0dd-14ffd201481f, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:16:16,479 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 33e2db56-43f5-49f7-a0dd-14ffd201481f, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_16_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:16:16,481 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 33e2db56-43f5-49f7-a0dd-14ffd201481f, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:16:16,758 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:16,759 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:16,760 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2e61375d-66a4-4c63-a99e-081e516439ee, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:16:16,760 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2e61375d-66a4-4c63-a99e-081e516439ee, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_16_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:16:16,762 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2e61375d-66a4-4c63-a99e-081e516439ee, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:16:17,014 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:17,015 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:17,016 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 49f7da83-93d2-4bfc-b441-c166d1a4b146, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:16:17,017 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 49f7da83-93d2-4bfc-b441-c166d1a4b146, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_16_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:16:17,025 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 49f7da83-93d2-4bfc-b441-c166d1a4b146, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:16:19,518 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:26,391 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-15 15:16:26,392 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-10-15 15:16:26,406 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-10-15 15:16:26,406 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 45602b68-43ec-4b84-9dea-ea7f55d9c1ba, localhost:10960): creating call state
2025-10-15 15:16:26,407 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 45602b68-43ec-4b84-9dea-ea7f55d9c1ba, localhost:10960): request = { database: "/Root" }
2025-10-15 15:16:26,414 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 45602b68-43ec-4b84-9dea-ea7f55d9c1ba, localhost:10960): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-lvxbqnxafi.auto.internal" port: 10960 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-10-15 15:16:26,415 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-lvxbqnxafi.auto.internal:10960, location 1, ssl: False>]>
2025-10-15 15:16:26,415 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:10960
2025-10-15 15:16:29,557 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:29,558 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, afc5ef80-f0f3-458b-9de1-92e2318c8fc4, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:16:29,559 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, afc5ef80-f0f3-458b-9de1-92e2318c8fc4, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_16_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:16:29,561 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, afc5ef80-f0f3-458b-9de1-92e2318c8fc4, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:16:31,676 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:31,701 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_16_compression`, volumes `value` (8000000, 1561528)
2025-10-15 15:16:31,701 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:31,702 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8555873d-c969-4e16-9e8b-1f332e61d498, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:16:31,703 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8555873d-c969-4e16-9e8b-1f332e61d498, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_16_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:16:31,705 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8555873d-c969-4e16-9e8b-1f332e61d498, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:16:31,991 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:31,992 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:31,992 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4281961f-8eae-424f-8975-d9531a980118, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:16:31,994 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4281961f-8eae-424f-8975-d9531a980118, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_16_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:16:31,995 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4281961f-8eae-424f-8975-d9531a980118, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:16:34,082 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:44,107 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:44,109 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7d0abffb-3fbc-49b5-ad75-d15411ba9bf7, ghrun-lvxbqnxafi.auto.internal:10960): creating call state
2025-10-15 15:16:44,110 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7d0abffb-3fbc-49b5-ad75-d15411ba9bf7, ghrun-lvxbqnxafi.auto.internal:10960): request = { session_id: "ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_16_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-10-15 15:16:44,111 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7d0abffb-3fbc-49b5-ad75-d15411ba9bf7, ghrun-lvxbqnxafi.auto.internal:10960): response = { <_MultiThreadedRendezvous object> }
2025-10-15 15:16:46,243 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MzBkNjAxYS1hMTQxYzZlZi0yN2NmNzFhNC1kZTI3NzJkNA==
2025-10-15 15:16:46,267 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_16_compression`, volumes `value` (8000000, 1561528)
2025-10-15 15:16:46,268 - INFO - root - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_16_compression` 8078192 / 1561528: 5.1732610622415995
2025-10-15 15:16:46,270 - INFO - ya.test - pytest_runtest_teardown: Test teardown
