2025-12-23 19:01:35,132 - INFO - ya.test.1663363  - pytest_runtest_setup: ####################################################################################################
2025-12-23 19:01:35,132 - INFO - ya.test.1663363  - pytest_runtest_setup: test_all_supported_compression[zstd_12_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 12]
2025-12-23 19:01:35,133 - INFO - ya.test.1663363  - pytest_runtest_setup: ####################################################################################################
2025-12-23 19:01:35,133 - INFO - ya.test.1663363  - pytest_runtest_setup: Test setup
2025-12-23 19:01:35,135 - DEBUG - ya.test.1663363  - _get_command_output_file: Command out will be placed to ydbd.out
2025-12-23 19:01:35,136 - DEBUG - ya.test.1663363  - _get_command_output_file: Command err will be placed to ydbd.err
2025-12-23 19:01:35,137 - DEBUG - ya.test.1663363  - execute: Executing '['/home/runner/.ya/build/build_root/8ptz/0046a4/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-23 19:01:35,143 - DEBUG - ya.test.1663363  - execute: Command pid: 1664149
2025-12-23 19:01:36,203 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664149) rc: 0
2025-12-23 19:01:36,204 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664149) elapsed time (sec): 1.058840036392212
2025-12-23 19:01:36,204 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664149) idrss: 0
2025-12-23 19:01:36,204 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664149) inblock: 0
2025-12-23 19:01:36,205 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664149) isrss: 0
2025-12-23 19:01:36,205 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664149) ixrss: 0
2025-12-23 19:01:36,205 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664149) majflt: 0
2025-12-23 19:01:36,206 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664149) maxrss: 486264
2025-12-23 19:01:36,206 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664149) minflt: 45856
2025-12-23 19:01:36,206 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664149) msgrcv: 0
2025-12-23 19:01:36,211 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664149) msgsnd: 0
2025-12-23 19:01:36,211 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664149) nivcsw: 182
2025-12-23 19:01:36,212 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664149) nsignals: 0
2025-12-23 19:01:36,212 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664149) nswap: 0
2025-12-23 19:01:36,212 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664149) nvcsw: 14
2025-12-23 19:01:36,212 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664149) oublock: 8
2025-12-23 19:01:36,213 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664149) stime: 0.23505399999999999
2025-12-23 19:01:36,213 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664149) utime: 0.587147
2025-12-23 19:01:36,213 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664149) wtime: 1.066
2025-12-23 19:01:36,214 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664149) output:
Git info:
    Commit: 09729cc9cf0669d9f027468138c7d2dc45a65d8c
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge ff1b65d8e0d4692b69b059de261ca6f72c94cd74 into 7a46c6293674d1de550a9922546b7e0022176cfa
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-ou4bsyjxme    Host information: 
        Linux ghrun-ou4bsyjxme 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

     
Build info:
    Compiler: /home/runner/.ya/tools/v4/10492077879/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10492077879/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -fsanitize=address -Daddress_sanitizer_enabled -fno-omit-frame-pointer -fsanitize-blacklist=/home/runner/actions_runner/_work/ydb/ydb/build/sanitize-blacklist.txt -fno-sanitize-link-runtime -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-12-23 19:01:36,214 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664149) errors:

2025-12-23 19:01:36,231 - INFO - __tests__.base.1663363  - _setup_ydb: Git info:
    Commit: 09729cc9cf0669d9f027468138c7d2dc45a65d8c
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge ff1b65d8e0d4692b69b059de261ca6f72c94cd74 into 7a46c6293674d1de550a9922546b7e0022176cfa
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-ou4bsyjxme    Host information: 
        Linux ghrun-ou4bsyjxme 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

     
Build info:
    Compiler: /home/runner/.ya/tools/v4/10492077879/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10492077879/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -fsanitize=address -Daddress_sanitizer_enabled -fno-omit-frame-pointer -fsanitize-blacklist=/home/runner/actions_runner/_work/ydb/ydb/build/sanitize-blacklist.txt -fno-sanitize-link-runtime -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-12-23 19:01:36,596 - DEBUG - ya.test.1663363  - get_binary: Binary was found by /home/runner/.ya/build/build_root/8ptz/0046a4/ydb/apps/ydbd/ydbd
2025-12-23 19:01:36,597 - DEBUG - library.python.filelock.1663363  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/7364
2025-12-23 19:01:36,600 - DEBUG - ydb.tests.library.harness.kikimr_runner.1663363  - start: Working directory: /home/runner/.ya/build/build_root/8ptz/0046a4/r3tmp/kikimr_cluster_xhc9_4ty
2025-12-23 19:01:36,689 - DEBUG - ya.test.1663363  - get_binary: Binary was found by /home/runner/.ya/build/build_root/8ptz/0046a4/ydb/apps/ydbd/ydbd
2025-12-23 19:01:36,690 - DEBUG - library.python.filelock.1663363  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/19363
2025-12-23 19:01:36,691 - DEBUG - library.python.filelock.1663363  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/21308
2025-12-23 19:01:36,692 - DEBUG - library.python.filelock.1663363  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/14008
2025-12-23 19:01:36,692 - DEBUG - library.python.filelock.1663363  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/61390
2025-12-23 19:01:36,693 - INFO - ydb.tests.library.harness.kikimr_runner.1663363  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/8ptz/0046a4/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk1/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_12_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.12/cluster/kikimr_configs"
2025-12-23 19:01:36,694 - INFO - ydb.tests.library.harness.kikimr_runner.1663363  - __make_run_command: Final command: /home/runner/.ya/build/build_root/8ptz/0046a4/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=1 --log-file-name=/home/runner/.ya/build/build_root/8ptz/0046a4/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk1/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_12_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.12/cluster/node_1/logfile_5g5bv4gb.log --grpc-port=19363 --mon-port=21308 --ic-port=7364
2025-12-23 19:01:36,694 - DEBUG - ydb.tests.library.harness.kikimr_runner.1663363  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:19363/1, disk_size 68719476736
2025-12-23 19:01:36,695 - INFO - ydb.tests.library.harness.kikimr_runner.1663363  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/8ptz/0046a4/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk1/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_12_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.12/cluster/kikimr_configs"
2025-12-23 19:01:36,695 - INFO - ydb.tests.library.harness.kikimr_runner.1663363  - __make_run_command: Final command: /home/runner/.ya/build/build_root/8ptz/0046a4/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=1 --log-file-name=/home/runner/.ya/build/build_root/8ptz/0046a4/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk1/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_12_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.12/cluster/node_1/logfile_5g5bv4gb.log --grpc-port=19363 --mon-port=21308 --ic-port=7364
2025-12-23 19:01:36,696 - DEBUG - ya.test.1663363  - execute: Executing '('/home/runner/.ya/build/build_root/8ptz/0046a4/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/8ptz/0046a4/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk1/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_12_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.12/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/8ptz/0046a4/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk1/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_12_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.12/cluster/node_1/logfile_5g5bv4gb.log', '--grpc-port=19363', '--mon-port=21308', '--ic-port=7364')' in '/home/runner/.ya/build/build_root/8ptz/0046a4/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk1/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_12_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.12/cluster/node_1' (no wait)
2025-12-23 19:01:36,719 - DEBUG - ya.test.1663363  - execute: Command pid: 1664417
2025-12-23 19:01:36,720 - INFO - ydb.tests.library.harness.kikimr_runner.1663363  - start: Started node localhost:19363/1
2025-12-23 19:01:36,722 - DEBUG - ya.test.1663363  - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-12-23 19:01:36,731 - DEBUG - ya.test.1663363  - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-12-23 19:01:36,732 - DEBUG - ya.test.1663363  - execute: Executing '['/home/runner/.ya/build/build_root/8ptz/0046a4/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-23 19:01:36,745 - DEBUG - ya.test.1663363  - execute: Command pid: 1664426
2025-12-23 19:01:38,277 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664426) rc: 0
2025-12-23 19:01:38,278 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664426) elapsed time (sec): 1.5303757190704346
2025-12-23 19:01:38,278 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664426) idrss: 0
2025-12-23 19:01:38,279 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664426) inblock: 0
2025-12-23 19:01:38,279 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664426) isrss: 0
2025-12-23 19:01:38,280 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664426) ixrss: 0
2025-12-23 19:01:38,280 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664426) majflt: 0
2025-12-23 19:01:38,280 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664426) maxrss: 497700
2025-12-23 19:01:38,281 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664426) minflt: 45823
2025-12-23 19:01:38,281 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664426) msgrcv: 0
2025-12-23 19:01:38,281 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664426) msgsnd: 0
2025-12-23 19:01:38,282 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664426) nivcsw: 230
2025-12-23 19:01:38,282 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664426) nsignals: 0
2025-12-23 19:01:38,282 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664426) nswap: 0
2025-12-23 19:01:38,292 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664426) nvcsw: 15
2025-12-23 19:01:38,324 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664426) oublock: 8
2025-12-23 19:01:38,324 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664426) stime: 0.240083
2025-12-23 19:01:38,325 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664426) utime: 0.567549
2025-12-23 19:01:38,325 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664426) wtime: 1.544
2025-12-23 19:01:38,325 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664426) output:
Git info:
    Commit: 09729cc9cf0669d9f027468138c7d2dc45a65d8c
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge ff1b65d8e0d4692b69b059de261ca6f72c94cd74 into 7a46c6293674d1de550a9922546b7e0022176cfa
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-ou4bsyjxme    Host information: 
        Linux ghrun-ou4bsyjxme 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

     
Build info:
    Compiler: /home/runner/.ya/tools/v4/10492077879/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10492077879/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -fsanitize=address -Daddress_sanitizer_enabled -fno-omit-frame-pointer -fsanitize-blacklist=/home/runner/actions_runner/_work/ydb/ydb/build/sanitize-blacklist.txt -fno-sanitize-link-runtime -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-12-23 19:01:38,326 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1664426) errors:

2025-12-23 19:01:38,327 - INFO - ydb.tests.library.harness.kikimr_runner.1663363  - start: Node 1 version:
Git info:
    Commit: 09729cc9cf0669d9f027468138c7d2dc45a65d8c
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge ff1b65d8e0d4692b69b059de261ca6f72c94cd74 into 7a46c6293674d1de550a9922546b7e0022176cfa
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-ou4bsyjxme    Host information: 
        Linux ghrun-ou4bsyjxme 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64
2025-12-23 19:01:44,542 - DEBUG - ya.test.1663363  - get_binary: Binary was found by /home/runner/.ya/build/build_root/8ptz/0046a4/ydb/apps/ydbd/ydbd
2025-12-23 19:01:44,543 - DEBUG - ydb.tests.library.harness.kikimr_runner.1663363  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/8ptz/0046a4/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:19363', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineHostConfig {\n    HostConfigId: 1\n    Drive {\n      Path: "SectorMap:1:64"\n    }\n  }\n}\nCommand {\n  DefineBox {\n    BoxId: 1\n    Host {\n      Key {\n        Fqdn: "localhost"\n        IcPort: 7364\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-12-23 19:01:44,544 - DEBUG - ya.test.1663363  - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-12-23 19:01:44,545 - DEBUG - ya.test.1663363  - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-12-23 19:01:44,545 - DEBUG - ya.test.1663363  - execute: Executing '['/home/runner/.ya/build/build_root/8ptz/0046a4/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:19363', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineHostConfig {\n    HostConfigId: 1\n    Drive {\n      Path: "SectorMap:1:64"\n    }\n  }\n}\nCommand {\n  DefineBox {\n    BoxId: 1\n    Host {\n      Key {\n        Fqdn: "localhost"\n        IcPort: 7364\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-12-23 19:01:44,575 - DEBUG - ya.test.1663363  - execute: Command pid: 1665754
2025-12-23 19:01:46,234 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1665754) rc: 0
2025-12-23 19:01:46,235 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1665754) elapsed time (sec): 1.6577250957489014
2025-12-23 19:01:46,235 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1665754) idrss: 0
2025-12-23 19:01:46,235 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1665754) inblock: 0
2025-12-23 19:01:46,236 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1665754) isrss: 0
2025-12-23 19:01:46,236 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1665754) ixrss: 0
2025-12-23 19:01:46,236 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1665754) majflt: 0
2025-12-23 19:01:46,237 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1665754) maxrss: 587092
2025-12-23 19:01:46,237 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1665754) minflt: 52350
2025-12-23 19:01:46,237 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1665754) msgrcv: 0
2025-12-23 19:01:46,237 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1665754) msgsnd: 0
2025-12-23 19:01:46,238 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1665754) nivcsw: 206
2025-12-23 19:01:46,238 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1665754) nsignals: 0
2025-12-23 19:01:46,238 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1665754) nswap: 0
2025-12-23 19:01:46,242 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1665754) nvcsw: 679
2025-12-23 19:01:46,243 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1665754) oublock: 8
2025-12-23 19:01:46,243 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1665754) stime: 0.29781799999999997
2025-12-23 19:01:46,243 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1665754) utime: 0.599335
2025-12-23 19:01:46,243 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1665754) wtime: 1.688
2025-12-23 19:01:46,244 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1665754) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-12-23 19:01:46,244 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1665754) errors:

2025-12-23 19:01:46,246 - DEBUG - ya.test.1663363  - get_binary: Binary was found by /home/runner/.ya/build/build_root/8ptz/0046a4/ydb/apps/ydbd/ydbd
2025-12-23 19:01:46,246 - DEBUG - ydb.tests.library.harness.kikimr_runner.1663363  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/8ptz/0046a4/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:19363', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']
2025-12-23 19:01:46,247 - DEBUG - ya.test.1663363  - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-12-23 19:01:46,248 - DEBUG - ya.test.1663363  - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-12-23 19:01:46,249 - DEBUG - ya.test.1663363  - execute: Executing '['/home/runner/.ya/build/build_root/8ptz/0046a4/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:19363', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']' in 'None' (waiting)
2025-12-23 19:01:46,279 - DEBUG - ya.test.1663363  - execute: Command pid: 1666050
2025-12-23 19:01:47,866 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1666050) rc: 0
2025-12-23 19:01:47,866 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1666050) elapsed time (sec): 1.5859935283660889
2025-12-23 19:01:47,867 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1666050) idrss: 0
2025-12-23 19:01:47,867 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1666050) inblock: 0
2025-12-23 19:01:47,867 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1666050) isrss: 0
2025-12-23 19:01:47,867 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1666050) ixrss: 0
2025-12-23 19:01:47,868 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1666050) majflt: 0
2025-12-23 19:01:47,868 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1666050) maxrss: 587956
2025-12-23 19:01:47,868 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1666050) minflt: 52173
2025-12-23 19:01:47,868 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1666050) msgrcv: 0
2025-12-23 19:01:47,869 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1666050) msgsnd: 0
2025-12-23 19:01:47,869 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1666050) nivcsw: 286
2025-12-23 19:01:47,869 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1666050) nsignals: 0
2025-12-23 19:01:47,870 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1666050) nswap: 0
2025-12-23 19:01:47,870 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1666050) nvcsw: 443
2025-12-23 19:01:47,870 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1666050) oublock: 8
2025-12-23 19:01:47,871 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1666050) stime: 0.2799
2025-12-23 19:01:47,871 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1666050) utime: 0.613131
2025-12-23 19:01:47,871 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1666050) wtime: 1.616
2025-12-23 19:01:47,871 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1666050) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-12-23 19:01:47,872 - DEBUG - ya.test.1663363  - _save_outputs: Command (pid 1666050) errors:

2025-12-23 19:01:47,872 - INFO - ydb.tests.library.harness.kikimr_runner.1663363  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-12-23 19:01:48,443 - INFO - ydb.tests.library.harness.kikimr_runner.1663363  - __run: Cluster started and initialized
2025-12-23 19:01:48,508 - DEBUG - ydb.connection.1663363  - 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', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 19:01:48,519 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1663363  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-23 19:01:48,520 - DEBUG - ydb.connection.1663363  - 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', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 19:01:48,592 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1663363  - context_resolve: Resolving endpoints for database /Root
2025-12-23 19:01:48,593 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ListEndpoints, cd02e080-bd9e-46b3-9f2f-f8160b1e1411, localhost:19363): creating call state
2025-12-23 19:01:48,594 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ListEndpoints, cd02e080-bd9e-46b3-9f2f-f8160b1e1411, localhost:19363): request = { database: "/Root" }
2025-12-23 19:01:48,605 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ListEndpoints, cd02e080-bd9e-46b3-9f2f-f8160b1e1411, localhost:19363): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-ou4bsyjxme.auto.internal" port: 19363 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-23 19:01:48,606 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1663363  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-ou4bsyjxme.auto.internal:19363, location 1, ssl: False>]>
2025-12-23 19:01:48,610 - DEBUG - ydb.connection.1663363  - 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', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 19:01:48,634 - DEBUG - ydb.connection.1663363  - close: Closing channel for endpoint localhost:19363
2025-12-23 19:01:48,635 - DEBUG - ydb.query.pool.1663363  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-23 19:01:48,636 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(CreateSession, 86f4953f-21eb-4815-a355-aa3b27cd6d6a, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:01:48,637 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(CreateSession, 86f4953f-21eb-4815-a355-aa3b27cd6d6a, ghrun-ou4bsyjxme.auto.internal:19363): request = {  }
2025-12-23 19:01:48,648 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(CreateSession, 86f4953f-21eb-4815-a355-aa3b27cd6d6a, ghrun-ou4bsyjxme.auto.internal:19363): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" node_id: 1 }
2025-12-23 19:01:48,649 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(AttachSession, 9246d692-a94f-4d0a-9b9a-b1b7dc9d9b70, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:01:48,650 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(AttachSession, 9246d692-a94f-4d0a-9b9a-b1b7dc9d9b70, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" }
2025-12-23 19:01:48,654 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(AttachSession, 9246d692-a94f-4d0a-9b9a-b1b7dc9d9b70, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:48,679 - DEBUG - ydb.query.pool.1663363  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:01:48,680 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 9c62f477-698a-485c-bf96-77d97642d070, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:01:48,681 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 9c62f477-698a-485c-bf96-77d97642d070, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/off_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"off\")\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-23 19:01:48,683 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 9c62f477-698a-485c-bf96-77d97642d070, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:52,905 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:01:52,906 - INFO - __tests__.alter_compression.1663363  - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-12-23 19:01:52,907 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:01:52,907 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, dccd8f42-93cc-4d2a-8145-2e7d97e34c65, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:01:52,908 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, dccd8f42-93cc-4d2a-8145-2e7d97e34c65, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/off_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:01:52,909 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, dccd8f42-93cc-4d2a-8145-2e7d97e34c65, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:54,883 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:01:54,884 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:01:54,885 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 71036068-1193-4ec3-83a2-387972848875, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:01:54,886 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 71036068-1193-4ec3-83a2-387972848875, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:01:54,888 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 71036068-1193-4ec3-83a2-387972848875, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:56,713 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:01:56,714 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:01:56,715 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 643ff09e-81c2-4b60-84c4-e73a83a7fd85, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:01:56,716 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 643ff09e-81c2-4b60-84c4-e73a83a7fd85, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:01:56,717 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 643ff09e-81c2-4b60-84c4-e73a83a7fd85, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:58,065 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:01:58,066 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:01:58,067 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 89c60336-5322-4509-8771-769d850de295, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:01:58,068 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 89c60336-5322-4509-8771-769d850de295, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:01:58,130 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 89c60336-5322-4509-8771-769d850de295, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:01,163 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:01,164 - INFO - __tests__.alter_compression.1663363  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 1618432, 'BlobCount': 128}}
2025-12-23 19:02:01,164 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:01,165 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, e9724dc9-67cd-4d86-baeb-25d14acaa12e, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:01,166 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, e9724dc9-67cd-4d86-baeb-25d14acaa12e, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:02:01,167 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, e9724dc9-67cd-4d86-baeb-25d14acaa12e, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:02,847 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:02,848 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:02,849 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, ec537b34-93bf-4576-929a-e6ff304a3b84, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:02,850 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, ec537b34-93bf-4576-929a-e6ff304a3b84, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:02:02,852 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, ec537b34-93bf-4576-929a-e6ff304a3b84, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:03,419 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:03,420 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:03,423 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, df914945-1ca0-4bd5-8a9d-b5697a76ccb3, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:03,424 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, df914945-1ca0-4bd5-8a9d-b5697a76ccb3, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:02:03,426 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, df914945-1ca0-4bd5-8a9d-b5697a76ccb3, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:04,024 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:04,025 - INFO - __tests__.alter_compression.1663363  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 3236864, 'BlobCount': 256}}
2025-12-23 19:02:04,026 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:04,026 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 718bc89b-4ce6-4ba1-812c-cc229f6abe71, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:04,028 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 718bc89b-4ce6-4ba1-812c-cc229f6abe71, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:02:04,030 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 718bc89b-4ce6-4ba1-812c-cc229f6abe71, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:05,254 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:05,255 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:05,256 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 6604aa3b-206d-4314-a233-d083e23085ad, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:05,257 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 6604aa3b-206d-4314-a233-d083e23085ad, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:02:05,266 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 6604aa3b-206d-4314-a233-d083e23085ad, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:05,590 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:05,591 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:05,592 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, a318dc8e-9a04-4b3c-b2ad-4313d69a05be, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:05,593 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, a318dc8e-9a04-4b3c-b2ad-4313d69a05be, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:02:05,594 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, a318dc8e-9a04-4b3c-b2ad-4313d69a05be, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:06,342 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:06,343 - INFO - __tests__.alter_compression.1663363  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 4855296, 'BlobCount': 384}}
2025-12-23 19:02:06,343 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:06,344 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 7c4dbf11-2c87-414e-a3ed-897493989cb0, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:06,345 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 7c4dbf11-2c87-414e-a3ed-897493989cb0, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:02:06,363 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 7c4dbf11-2c87-414e-a3ed-897493989cb0, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:08,282 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:08,283 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:08,284 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 81bf676d-b05d-41a9-8839-c8997551992a, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:08,284 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 81bf676d-b05d-41a9-8839-c8997551992a, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:02:08,285 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 81bf676d-b05d-41a9-8839-c8997551992a, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:09,035 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:09,036 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:09,037 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 982b83e5-3023-4605-8a60-d6ed8a8a8f98, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:09,037 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 982b83e5-3023-4605-8a60-d6ed8a8a8f98, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:02:09,040 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 982b83e5-3023-4605-8a60-d6ed8a8a8f98, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:09,926 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:09,927 - INFO - __tests__.alter_compression.1663363  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 6473728, 'BlobCount': 512}}
2025-12-23 19:02:09,928 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:09,928 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, a0b2d33c-9b58-4454-929a-21441ca43df8, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:09,929 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, a0b2d33c-9b58-4454-929a-21441ca43df8, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:02:09,932 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, a0b2d33c-9b58-4454-929a-21441ca43df8, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:11,336 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:11,337 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:11,337 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 1b7d2f87-8cce-47ed-9e10-4aeafb26e2ba, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:11,338 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 1b7d2f87-8cce-47ed-9e10-4aeafb26e2ba, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:02:11,339 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 1b7d2f87-8cce-47ed-9e10-4aeafb26e2ba, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:11,918 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:11,918 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:11,919 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 6e57f21a-8658-4a48-9c48-b68199b54da3, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:11,920 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 6e57f21a-8658-4a48-9c48-b68199b54da3, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:02:11,923 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 6e57f21a-8658-4a48-9c48-b68199b54da3, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:12,735 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:12,735 - INFO - __tests__.alter_compression.1663363  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 8092160, 'BlobCount': 640}}
2025-12-23 19:02:12,736 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:12,736 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, f8eaaf5d-1ba5-40d9-ac11-5bada0c99334, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:12,737 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, f8eaaf5d-1ba5-40d9-ac11-5bada0c99334, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:02:12,748 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, f8eaaf5d-1ba5-40d9-ac11-5bada0c99334, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:14,188 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:14,188 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:14,189 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, bd151810-67a8-4ed0-91b8-6ff9001807e4, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:14,190 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, bd151810-67a8-4ed0-91b8-6ff9001807e4, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:02:14,191 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, bd151810-67a8-4ed0-91b8-6ff9001807e4, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:14,675 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:14,676 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:14,676 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 91c09b4a-5211-493f-9b64-a8b73dedcf35, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:14,677 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 91c09b4a-5211-493f-9b64-a8b73dedcf35, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:02:14,682 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 91c09b4a-5211-493f-9b64-a8b73dedcf35, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:16,062 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:16,063 - INFO - __tests__.alter_compression.1663363  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 9710592, 'BlobCount': 768}}
2025-12-23 19:02:16,063 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:16,064 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, a24a32d7-7f77-4b66-8796-cc4d91f369c9, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:16,065 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, a24a32d7-7f77-4b66-8796-cc4d91f369c9, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:02:16,066 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, a24a32d7-7f77-4b66-8796-cc4d91f369c9, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:18,697 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:18,698 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:18,699 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, c498c4bb-5fd3-4181-9c4d-cf6231b869ac, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:18,700 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, c498c4bb-5fd3-4181-9c4d-cf6231b869ac, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:02:18,701 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, c498c4bb-5fd3-4181-9c4d-cf6231b869ac, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:19,540 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:19,541 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:19,542 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 341a30e9-762f-4ad9-aa2c-196ba8ced0d3, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:19,543 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 341a30e9-762f-4ad9-aa2c-196ba8ced0d3, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:02:19,545 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 341a30e9-762f-4ad9-aa2c-196ba8ced0d3, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:21,827 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:21,828 - INFO - __tests__.alter_compression.1663363  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 11329024, 'BlobCount': 896}}
2025-12-23 19:02:21,828 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:21,829 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 29f83ca1-9c91-4bfb-bbd4-ea452abb04ee, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:21,830 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 29f83ca1-9c91-4bfb-bbd4-ea452abb04ee, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:02:21,832 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 29f83ca1-9c91-4bfb-bbd4-ea452abb04ee, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:23,760 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:23,760 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:23,761 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 19532a77-b75a-47c8-a26d-18c08e6b695f, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:23,762 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 19532a77-b75a-47c8-a26d-18c08e6b695f, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:02:23,763 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 19532a77-b75a-47c8-a26d-18c08e6b695f, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:24,319 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:24,320 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:24,320 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 4e8d729e-282f-4d2c-8f38-b8acebf97aff, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:24,321 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 4e8d729e-282f-4d2c-8f38-b8acebf97aff, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:02:24,349 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 4e8d729e-282f-4d2c-8f38-b8acebf97aff, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:25,887 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:25,888 - INFO - __tests__.alter_compression.1663363  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 12947456, 'BlobCount': 1024}}
2025-12-23 19:02:25,888 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:25,889 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 98bc0bf2-4c3c-4bd9-a229-601d6e2d6536, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:25,895 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 98bc0bf2-4c3c-4bd9-a229-601d6e2d6536, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:02:25,896 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 98bc0bf2-4c3c-4bd9-a229-601d6e2d6536, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:27,684 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:27,685 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:27,686 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, fd0ebd19-6bb2-4be5-a4ef-aba6b944860c, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:27,687 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, fd0ebd19-6bb2-4be5-a4ef-aba6b944860c, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:02:27,689 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, fd0ebd19-6bb2-4be5-a4ef-aba6b944860c, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:28,239 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:28,240 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:28,241 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 8da502f0-68b7-414c-a361-94b4eda94431, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:28,242 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 8da502f0-68b7-414c-a361-94b4eda94431, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:02:28,256 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 8da502f0-68b7-414c-a361-94b4eda94431, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:29,683 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:29,684 - INFO - __tests__.alter_compression.1663363  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 14565888, 'BlobCount': 1152}}
2025-12-23 19:02:29,684 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:29,685 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, c67f4aea-37ca-47bc-b6d4-cef58018abe4, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:29,686 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, c67f4aea-37ca-47bc-b6d4-cef58018abe4, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:02:29,695 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, c67f4aea-37ca-47bc-b6d4-cef58018abe4, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:31,012 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:31,013 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:31,014 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 0423f625-5e86-4ec2-8dd4-3d490ba32871, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:31,015 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 0423f625-5e86-4ec2-8dd4-3d490ba32871, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:02:31,016 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 0423f625-5e86-4ec2-8dd4-3d490ba32871, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:31,630 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:31,631 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:31,632 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, b57f17e6-7a2a-47d7-8a66-ce9d8f8a8883, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:31,633 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, b57f17e6-7a2a-47d7-8a66-ce9d8f8a8883, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:02:31,635 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, b57f17e6-7a2a-47d7-8a66-ce9d8f8a8883, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:32,566 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:32,567 - INFO - __tests__.alter_compression.1663363  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 16184320, 'BlobCount': 1280}}
2025-12-23 19:02:32,567 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:32,568 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, a7c0e290-872b-4651-9c38-fcfa8e3d3a2c, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:32,568 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, a7c0e290-872b-4651-9c38-fcfa8e3d3a2c, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/off_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:02:32,570 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, a7c0e290-872b-4651-9c38-fcfa8e3d3a2c, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:34,081 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:34,082 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:34,083 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 8b590dd8-219b-4822-8e87-0aa4c9c364c6, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:34,084 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 8b590dd8-219b-4822-8e87-0aa4c9c364c6, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:02:34,085 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 8b590dd8-219b-4822-8e87-0aa4c9c364c6, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:34,585 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:34,585 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:34,586 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, be8a2bce-2ecc-498f-994c-26d533f4d9f0, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:34,587 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, be8a2bce-2ecc-498f-994c-26d533f4d9f0, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:02:34,588 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, be8a2bce-2ecc-498f-994c-26d533f4d9f0, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:35,157 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:35,158 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:35,159 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 7996a13e-ffbc-4ec2-95ff-cc1fcb6fddfa, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:35,160 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 7996a13e-ffbc-4ec2-95ff-cc1fcb6fddfa, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_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-23 19:02:35,161 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 7996a13e-ffbc-4ec2-95ff-cc1fcb6fddfa, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:41,915 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:51,995 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:02:51,996 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, ddad69c2-c264-4a02-8ab4-4dfe34b1cb04, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:02:51,997 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, ddad69c2-c264-4a02-8ab4-4dfe34b1cb04, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_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-23 19:02:52,000 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, ddad69c2-c264-4a02-8ab4-4dfe34b1cb04, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:56,623 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:06,655 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:06,656 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 574e1b23-2eeb-44e4-8558-5aa7fefa16bf, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:03:06,658 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 574e1b23-2eeb-44e4-8558-5aa7fefa16bf, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_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-23 19:03:06,661 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 574e1b23-2eeb-44e4-8558-5aa7fefa16bf, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:07,561 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:17,565 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:17,566 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, d3858acd-8cac-4fcb-b9e7-229912d472a1, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:03:17,567 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, d3858acd-8cac-4fcb-b9e7-229912d472a1, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_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-23 19:03:17,568 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, d3858acd-8cac-4fcb-b9e7-229912d472a1, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:18,397 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:18,402 - INFO - root.1663363  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8009216)
2025-12-23 19:03:18,405 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:18,406 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 118659c0-2c8c-457f-951a-508edbeacde8, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:03:18,407 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 118659c0-2c8c-457f-951a-508edbeacde8, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_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-23 19:03:18,409 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 118659c0-2c8c-457f-951a-508edbeacde8, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:19,487 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:22,134 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1663363  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-23 19:03:22,135 - DEBUG - ydb.connection.1663363  - 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', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 19:03:22,177 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1663363  - context_resolve: Resolving endpoints for database /Root
2025-12-23 19:03:22,177 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ListEndpoints, 662d5f49-3a59-4940-a2ee-a9d36f3a40d6, localhost:19363): creating call state
2025-12-23 19:03:22,178 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ListEndpoints, 662d5f49-3a59-4940-a2ee-a9d36f3a40d6, localhost:19363): request = { database: "/Root" }
2025-12-23 19:03:22,188 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ListEndpoints, 662d5f49-3a59-4940-a2ee-a9d36f3a40d6, localhost:19363): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-ou4bsyjxme.auto.internal" port: 19363 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-23 19:03:22,189 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1663363  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-ou4bsyjxme.auto.internal:19363, location 1, ssl: False>]>
2025-12-23 19:03:22,190 - DEBUG - ydb.connection.1663363  - close: Closing channel for endpoint localhost:19363
2025-12-23 19:03:29,495 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:29,496 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, a7df781e-c1dc-41e4-ac18-ee0c8cf7623e, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:03:29,497 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, a7df781e-c1dc-41e4-ac18-ee0c8cf7623e, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_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-23 19:03:29,508 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, a7df781e-c1dc-41e4-ac18-ee0c8cf7623e, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:30,404 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:30,410 - INFO - root.1663363  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8009216)
2025-12-23 19:03:30,411 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:30,411 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, b67579dc-df4a-4557-add2-fbcd177f6127, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:03:30,413 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, b67579dc-df4a-4557-add2-fbcd177f6127, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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/off_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-23 19:03:30,416 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, b67579dc-df4a-4557-add2-fbcd177f6127, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:30,904 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:30,908 - INFO - ya.test.1663363  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_12_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 12])
2025-12-23 19:03:30,909 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:30,910 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, f92ce3a9-c7ff-48c1-a195-dad60c633af4, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:03:30,919 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, f92ce3a9-c7ff-48c1-a195-dad60c633af4, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_12_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 12)\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-23 19:03:30,920 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, f92ce3a9-c7ff-48c1-a195-dad60c633af4, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:35,107 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:35,107 - INFO - __tests__.alter_compression.1663363  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_12_compression created
2025-12-23 19:03:35,108 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:35,109 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 70e44e80-297c-493d-a143-705bf40c0227, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:03:35,110 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 70e44e80-297c-493d-a143-705bf40c0227, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_12_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:35,116 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 70e44e80-297c-493d-a143-705bf40c0227, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:36,385 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:36,386 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:36,387 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 45742184-e32c-4ba2-b927-f0ba48c6f6c9, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:03:36,388 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 45742184-e32c-4ba2-b927-f0ba48c6f6c9, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:03:36,389 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 45742184-e32c-4ba2-b927-f0ba48c6f6c9, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:40,355 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:40,356 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:40,357 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, d4853b2c-c9a0-4173-98ac-1df6a0b064fc, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:03:40,358 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, d4853b2c-c9a0-4173-98ac-1df6a0b064fc, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:03:40,360 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, d4853b2c-c9a0-4173-98ac-1df6a0b064fc, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:41,436 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:41,437 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:41,438 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 44124bf8-5ba5-41db-8371-ec7f5d940146, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:03:41,439 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 44124bf8-5ba5-41db-8371-ec7f5d940146, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:03:41,440 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 44124bf8-5ba5-41db-8371-ec7f5d940146, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:43,559 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:43,560 - INFO - __tests__.alter_compression.1663363  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 375776, 'BlobCount': 128}}
2025-12-23 19:03:43,560 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:43,561 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, b23861e1-da73-443a-b651-6013492df484, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:03:43,562 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, b23861e1-da73-443a-b651-6013492df484, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:03:43,565 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, b23861e1-da73-443a-b651-6013492df484, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:47,155 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:47,155 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:47,156 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 1400d323-4850-4f9c-94e1-1f2480322d08, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:03:47,157 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 1400d323-4850-4f9c-94e1-1f2480322d08, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:03:47,163 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 1400d323-4850-4f9c-94e1-1f2480322d08, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:47,533 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:47,534 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:47,535 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 74e72609-108a-4e25-9abc-a1d647eadb1a, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:03:47,536 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 74e72609-108a-4e25-9abc-a1d647eadb1a, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:03:47,537 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 74e72609-108a-4e25-9abc-a1d647eadb1a, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:47,947 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:47,948 - INFO - __tests__.alter_compression.1663363  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 753024, 'BlobCount': 256}}
2025-12-23 19:03:47,958 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:47,966 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 7b0bb0e2-c427-4f8b-ba31-6bd3f26bb3a6, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:03:47,967 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 7b0bb0e2-c427-4f8b-ba31-6bd3f26bb3a6, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:03:47,968 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 7b0bb0e2-c427-4f8b-ba31-6bd3f26bb3a6, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:51,012 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:51,013 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:51,013 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, b6992b77-aa9e-4187-86d0-650455e8b1d8, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:03:51,014 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, b6992b77-aa9e-4187-86d0-650455e8b1d8, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:03:51,015 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, b6992b77-aa9e-4187-86d0-650455e8b1d8, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:51,351 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:51,352 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:51,352 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 0cd65c96-7941-4cda-a96f-def5be3087c4, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:03:51,353 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 0cd65c96-7941-4cda-a96f-def5be3087c4, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:03:51,359 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 0cd65c96-7941-4cda-a96f-def5be3087c4, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:52,026 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:52,026 - INFO - __tests__.alter_compression.1663363  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 1129904, 'BlobCount': 384}}
2025-12-23 19:03:52,027 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:52,032 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, e440c192-06b5-4e72-9476-36dbc4edecf4, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:03:52,033 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, e440c192-06b5-4e72-9476-36dbc4edecf4, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:03:52,034 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, e440c192-06b5-4e72-9476-36dbc4edecf4, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:55,847 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:55,847 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:55,848 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 6d9d86a2-ef1e-49b9-8e1d-48ab4164486e, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:03:55,849 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 6d9d86a2-ef1e-49b9-8e1d-48ab4164486e, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:03:55,855 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 6d9d86a2-ef1e-49b9-8e1d-48ab4164486e, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:56,268 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:56,268 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:56,269 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 3d32b73a-1503-4d95-91f8-dba42da7edb3, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:03:56,270 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 3d32b73a-1503-4d95-91f8-dba42da7edb3, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:03:56,271 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 3d32b73a-1503-4d95-91f8-dba42da7edb3, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:56,858 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:56,859 - INFO - __tests__.alter_compression.1663363  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1507088, 'BlobCount': 512}}
2025-12-23 19:03:56,860 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:03:56,860 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 7ecb34d2-6a9a-4fa6-925c-77f64f35eac4, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:03:56,861 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 7ecb34d2-6a9a-4fa6-925c-77f64f35eac4, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:03:56,878 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 7ecb34d2-6a9a-4fa6-925c-77f64f35eac4, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:00,747 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:00,747 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:00,748 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, ef561469-a4d2-4edd-a403-94f38bd21f07, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:04:00,749 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, ef561469-a4d2-4edd-a403-94f38bd21f07, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:04:00,751 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, ef561469-a4d2-4edd-a403-94f38bd21f07, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:01,205 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:01,205 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:01,206 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 3012ca8a-6bf5-427c-963e-15ced32c48a4, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:04:01,207 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 3012ca8a-6bf5-427c-963e-15ced32c48a4, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:04:01,210 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 3012ca8a-6bf5-427c-963e-15ced32c48a4, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:02,045 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:02,046 - INFO - __tests__.alter_compression.1663363  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1883952, 'BlobCount': 640}}
2025-12-23 19:04:02,046 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:02,047 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 657b4f2e-c01d-4ce7-a831-1053e8d73497, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:04:02,048 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 657b4f2e-c01d-4ce7-a831-1053e8d73497, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:04:02,055 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 657b4f2e-c01d-4ce7-a831-1053e8d73497, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:06,063 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:06,064 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:06,065 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, e99a423e-e73a-4c83-8d45-87ddb8ef31c4, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:04:06,066 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, e99a423e-e73a-4c83-8d45-87ddb8ef31c4, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:04:06,068 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, e99a423e-e73a-4c83-8d45-87ddb8ef31c4, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:06,775 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:06,776 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:06,777 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 7cc034f7-663b-4ef5-9fb8-afc3b55a94ab, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:04:06,778 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 7cc034f7-663b-4ef5-9fb8-afc3b55a94ab, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:04:06,783 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 7cc034f7-663b-4ef5-9fb8-afc3b55a94ab, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:07,992 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:07,993 - INFO - __tests__.alter_compression.1663363  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 2261152, 'BlobCount': 768}}
2025-12-23 19:04:07,994 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:07,994 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, ea81489c-a8fc-4058-923d-831a3e37dd78, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:04:07,996 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, ea81489c-a8fc-4058-923d-831a3e37dd78, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:04:08,003 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, ea81489c-a8fc-4058-923d-831a3e37dd78, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:12,045 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:12,046 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:12,046 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 8cbe7b15-f761-477d-a4b7-5083eb0d688a, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:04:12,047 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 8cbe7b15-f761-477d-a4b7-5083eb0d688a, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:04:12,049 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 8cbe7b15-f761-477d-a4b7-5083eb0d688a, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:12,484 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:12,485 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:12,485 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, d1f6f574-a61c-4d12-9d77-b3ee3506ce93, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:04:12,486 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, d1f6f574-a61c-4d12-9d77-b3ee3506ce93, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:04:12,488 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, d1f6f574-a61c-4d12-9d77-b3ee3506ce93, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:13,234 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:13,234 - INFO - __tests__.alter_compression.1663363  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2638128, 'BlobCount': 896}}
2025-12-23 19:04:13,235 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:13,236 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 87006dcd-e07b-4388-882a-05e76ab9dc64, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:04:13,236 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 87006dcd-e07b-4388-882a-05e76ab9dc64, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:04:13,238 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 87006dcd-e07b-4388-882a-05e76ab9dc64, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:16,740 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:16,741 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:16,741 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 46b86bc1-5404-4bd1-8eab-83c0f0778c43, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:04:16,742 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 46b86bc1-5404-4bd1-8eab-83c0f0778c43, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:04:16,744 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 46b86bc1-5404-4bd1-8eab-83c0f0778c43, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:17,303 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:17,304 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:17,305 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 38086db6-16b8-4e89-b684-b31e160937ba, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:04:17,306 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 38086db6-16b8-4e89-b684-b31e160937ba, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:04:17,308 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 38086db6-16b8-4e89-b684-b31e160937ba, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:18,436 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:18,437 - INFO - __tests__.alter_compression.1663363  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 3015296, 'BlobCount': 1024}}
2025-12-23 19:04:18,438 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:18,438 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 05f6e75e-b192-452a-8aa8-f76b224238bf, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:04:18,439 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 05f6e75e-b192-452a-8aa8-f76b224238bf, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:04:18,454 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 05f6e75e-b192-452a-8aa8-f76b224238bf, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:22,885 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:22,886 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:22,886 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, cd79ed4d-54c9-4591-97b8-e6d7c8721f21, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:04:22,887 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, cd79ed4d-54c9-4591-97b8-e6d7c8721f21, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:04:22,888 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, cd79ed4d-54c9-4591-97b8-e6d7c8721f21, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:23,400 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:23,401 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:23,401 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, b3af3e53-1ecb-4574-a866-baf3abe554e4, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:04:23,402 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, b3af3e53-1ecb-4574-a866-baf3abe554e4, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:04:23,405 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, b3af3e53-1ecb-4574-a866-baf3abe554e4, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:24,420 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:24,420 - INFO - __tests__.alter_compression.1663363  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 3392304, 'BlobCount': 1152}}
2025-12-23 19:04:24,421 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:24,422 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 11edc302-dccf-49d2-bfa8-ce2bb2cf3c43, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:04:24,427 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 11edc302-dccf-49d2-bfa8-ce2bb2cf3c43, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:04:24,429 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 11edc302-dccf-49d2-bfa8-ce2bb2cf3c43, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:28,195 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:28,196 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:28,197 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 89052c30-f13c-4e05-bcbe-b43e5e0a05d8, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:04:28,198 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 89052c30-f13c-4e05-bcbe-b43e5e0a05d8, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:04:28,206 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 89052c30-f13c-4e05-bcbe-b43e5e0a05d8, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:28,883 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:28,884 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:28,885 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 1044ef7b-4972-44eb-9be4-70b453300969, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:04:28,886 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 1044ef7b-4972-44eb-9be4-70b453300969, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:04:28,888 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 1044ef7b-4972-44eb-9be4-70b453300969, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:29,702 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1663363  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-23 19:04:29,703 - DEBUG - ydb.connection.1663363  - 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', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 19:04:29,740 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1663363  - context_resolve: Resolving endpoints for database /Root
2025-12-23 19:04:29,741 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ListEndpoints, 2e37a03f-6ae4-4162-8224-252f807b400d, localhost:19363): creating call state
2025-12-23 19:04:29,741 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ListEndpoints, 2e37a03f-6ae4-4162-8224-252f807b400d, localhost:19363): request = { database: "/Root" }
2025-12-23 19:04:29,772 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ListEndpoints, 2e37a03f-6ae4-4162-8224-252f807b400d, localhost:19363): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-ou4bsyjxme.auto.internal" port: 19363 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-23 19:04:29,773 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1663363  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-ou4bsyjxme.auto.internal:19363, location 1, ssl: False>]>
2025-12-23 19:04:29,774 - DEBUG - ydb.connection.1663363  - close: Closing channel for endpoint localhost:19363
2025-12-23 19:04:30,187 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:30,188 - INFO - __tests__.alter_compression.1663363  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3769616, 'BlobCount': 1280}}
2025-12-23 19:04:30,189 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:30,189 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 198dcf58-9b60-4776-bfa1-ac361ce7204e, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:04:30,191 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 198dcf58-9b60-4776-bfa1-ac361ce7204e, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_12_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:04:30,193 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 198dcf58-9b60-4776-bfa1-ac361ce7204e, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:32,300 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:32,301 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:32,301 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, bf4e195b-0773-409a-a820-d399da31fe88, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:04:32,302 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, bf4e195b-0773-409a-a820-d399da31fe88, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:04:32,315 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, bf4e195b-0773-409a-a820-d399da31fe88, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:33,226 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:33,227 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:33,228 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 3ffec750-8d6c-43be-a8dc-5321393e91bc, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:04:33,229 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 3ffec750-8d6c-43be-a8dc-5321393e91bc, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:04:33,231 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 3ffec750-8d6c-43be-a8dc-5321393e91bc, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:34,005 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:34,006 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:34,007 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 3d971c14-045d-4a7a-bf95-b2cf44f2741a, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:04:34,008 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 3d971c14-045d-4a7a-bf95-b2cf44f2741a, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_12_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-23 19:04:34,011 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 3d971c14-045d-4a7a-bf95-b2cf44f2741a, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:41,002 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:51,071 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:04:51,072 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 390b6024-91de-497d-a359-6520f453d2ec, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:04:51,072 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 390b6024-91de-497d-a359-6520f453d2ec, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_12_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-23 19:04:51,074 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 390b6024-91de-497d-a359-6520f453d2ec, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:54,234 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:05:04,247 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:05:04,248 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 0e474f5c-aa75-4cd6-867a-da7b979ed8dd, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:05:04,248 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 0e474f5c-aa75-4cd6-867a-da7b979ed8dd, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_12_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-23 19:05:04,250 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 0e474f5c-aa75-4cd6-867a-da7b979ed8dd, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:05:05,536 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:05:15,543 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:05:15,544 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 6cb709f9-296d-473b-b5c5-5fa3cc47636c, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:05:15,545 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 6cb709f9-296d-473b-b5c5-5fa3cc47636c, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_12_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-23 19:05:15,546 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 6cb709f9-296d-473b-b5c5-5fa3cc47636c, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:05:16,579 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:05:16,584 - INFO - root.1663363  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_12_compression`, volumes `value` (8000000, 1465648)
2025-12-23 19:05:16,585 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:05:16,586 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 149b4732-9544-4066-85a7-ce5f169de7c0, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:05:16,587 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 149b4732-9544-4066-85a7-ce5f169de7c0, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" 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_12_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-23 19:05:16,588 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 149b4732-9544-4066-85a7-ce5f169de7c0, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:05:17,034 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:05:17,035 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:05:17,036 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 5961ab36-80c6-4ece-9baf-76e00b920775, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:05:17,037 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 5961ab36-80c6-4ece-9baf-76e00b920775, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_12_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-23 19:05:17,045 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 5961ab36-80c6-4ece-9baf-76e00b920775, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:05:18,062 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:05:28,067 - DEBUG - ydb.query.pool.1663363  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:05:28,068 - DEBUG - ydb.connection.1663363  - _prepare_call: RpcState(ExecuteQuery, 5932e9c7-b257-4861-a5b3-59ba85d3b41f, ghrun-ou4bsyjxme.auto.internal:19363): creating call state
2025-12-23 19:05:28,069 - DEBUG - ydb.connection.1663363  - _log_request: RpcState(ExecuteQuery, 5932e9c7-b257-4861-a5b3-59ba85d3b41f, ghrun-ou4bsyjxme.auto.internal:19363): request = { session_id: "ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_12_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-23 19:05:28,082 - DEBUG - ydb.connection.1663363  - _log_response: RpcState(ExecuteQuery, 5932e9c7-b257-4861-a5b3-59ba85d3b41f, ghrun-ou4bsyjxme.auto.internal:19363): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:05:29,098 - DEBUG - ydb.query.pool.1663363  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmE2YWIyZDctMWUyNGQ0YWYtNTYwYmJjYWEtYmVkODUwMWQ=
2025-12-23 19:05:29,101 - INFO - root.1663363  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_12_compression`, volumes `value` (8000000, 1465648)
2025-12-23 19:05:29,102 - INFO - root.1663363  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_12_compression` 8009216 / 1465648: 5.464624521030971
2025-12-23 19:05:29,104 - INFO - ya.test.1663363  - pytest_runtest_teardown: Test teardown
