2025-11-21 20:15:05,851 - INFO - ya.test.57987  - pytest_runtest_setup: ####################################################################################################
2025-11-21 20:15:05,851 - INFO - ya.test.57987  - pytest_runtest_setup: test_all_supported_compression[zstd_4_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 4]
2025-11-21 20:15:05,852 - INFO - ya.test.57987  - pytest_runtest_setup: ####################################################################################################
2025-11-21 20:15:05,852 - INFO - ya.test.57987  - pytest_runtest_setup: Test setup
2025-11-21 20:15:05,854 - DEBUG - ya.test.57987  - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-21 20:15:05,855 - DEBUG - ya.test.57987  - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-21 20:15:05,855 - DEBUG - ya.test.57987  - execute: Executing '['/home/runner/.ya/build/build_root/tshh/002765/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-21 20:15:05,856 - DEBUG - ya.test.57987  - execute: Command pid: 59193
2025-11-21 20:15:06,648 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59193) rc: 0
2025-11-21 20:15:06,649 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59193) elapsed time (sec): 0.7888083457946777
2025-11-21 20:15:06,649 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59193) idrss: 0
2025-11-21 20:15:06,650 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59193) inblock: 0
2025-11-21 20:15:06,650 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59193) isrss: 0
2025-11-21 20:15:06,650 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59193) ixrss: 0
2025-11-21 20:15:06,651 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59193) majflt: 0
2025-11-21 20:15:06,651 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59193) maxrss: 493892
2025-11-21 20:15:06,651 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59193) minflt: 45575
2025-11-21 20:15:06,652 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59193) msgrcv: 0
2025-11-21 20:15:06,652 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59193) msgsnd: 0
2025-11-21 20:15:06,652 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59193) nivcsw: 96
2025-11-21 20:15:06,653 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59193) nsignals: 0
2025-11-21 20:15:06,653 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59193) nswap: 0
2025-11-21 20:15:06,653 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59193) nvcsw: 14
2025-11-21 20:15:06,653 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59193) oublock: 8
2025-11-21 20:15:06,654 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59193) stime: 0.205005
2025-11-21 20:15:06,654 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59193) utime: 0.518002
2025-11-21 20:15:06,654 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59193) wtime: 0.791
2025-11-21 20:15:06,659 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59193) output:
Arc info:
    Branch: unknown-vcs-branch
    Commit: THIS_REVISION_IS_A_DUMMY
    Author: ordinal
    Summary: No VCS
    Last Changed Rev: -1
    Last Changed Date: 2015-03-14T06:05:35.000000Z
Other info:
    Build by: runner
    Top src dir: 
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-frzglb4yoy    Host information: 
        Linux ghrun-frzglb4yoy 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/10302026024/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10302026024/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-11-21 20:15:06,660 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59193) errors:

2025-11-21 20:15:06,660 - INFO - __tests__.base.57987  - _setup_ydb: Arc info:
    Branch: unknown-vcs-branch
    Commit: THIS_REVISION_IS_A_DUMMY
    Author: ordinal
    Summary: No VCS
    Last Changed Rev: -1
    Last Changed Date: 2015-03-14T06:05:35.000000Z
Other info:
    Build by: runner
    Top src dir: 
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-frzglb4yoy    Host information: 
        Linux ghrun-frzglb4yoy 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/10302026024/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10302026024/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-11-21 20:15:06,779 - DEBUG - ya.test.57987  - get_binary: Binary was found by /home/runner/.ya/build/build_root/tshh/002765/ydb/apps/ydbd/ydbd
2025-11-21 20:15:06,781 - DEBUG - library.python.filelock.57987  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/8775
2025-11-21 20:15:06,782 - DEBUG - ydb.tests.library.harness.kikimr_runner.57987  - start: Working directory: /home/runner/.ya/build/build_root/tshh/002765/r3tmp/kikimr_cluster_smvdwx6h
2025-11-21 20:15:06,817 - DEBUG - ya.test.57987  - get_binary: Binary was found by /home/runner/.ya/build/build_root/tshh/002765/ydb/apps/ydbd/ydbd
2025-11-21 20:15:06,818 - DEBUG - library.python.filelock.57987  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/30146
2025-11-21 20:15:06,819 - DEBUG - library.python.filelock.57987  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/15172
2025-11-21 20:15:06,819 - DEBUG - library.python.filelock.57987  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/19131
2025-11-21 20:15:06,820 - DEBUG - library.python.filelock.57987  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/25788
2025-11-21 20:15:06,821 - INFO - ydb.tests.library.harness.kikimr_runner.57987  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/tshh/002765/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/kikimr_configs"
2025-11-21 20:15:06,821 - INFO - ydb.tests.library.harness.kikimr_runner.57987  - __make_run_command: Final command: /home/runner/.ya/build/build_root/tshh/002765/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/tshh/002765/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/node_1/logfile_ro7jhq9k.log --grpc-port=30146 --mon-port=15172 --ic-port=8775
2025-11-21 20:15:06,822 - DEBUG - ydb.tests.library.harness.kikimr_runner.57987  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:30146/1, disk_size 68719476736
2025-11-21 20:15:06,822 - INFO - ydb.tests.library.harness.kikimr_runner.57987  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/tshh/002765/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/kikimr_configs"
2025-11-21 20:15:06,822 - INFO - ydb.tests.library.harness.kikimr_runner.57987  - __make_run_command: Final command: /home/runner/.ya/build/build_root/tshh/002765/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/tshh/002765/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/node_1/logfile_ro7jhq9k.log --grpc-port=30146 --mon-port=15172 --ic-port=8775
2025-11-21 20:15:06,824 - DEBUG - ya.test.57987  - execute: Executing '('/home/runner/.ya/build/build_root/tshh/002765/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/tshh/002765/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/tshh/002765/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/node_1/logfile_ro7jhq9k.log', '--grpc-port=30146', '--mon-port=15172', '--ic-port=8775')' in '/home/runner/.ya/build/build_root/tshh/002765/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/node_1' (no wait)
2025-11-21 20:15:06,836 - DEBUG - ya.test.57987  - execute: Command pid: 59391
2025-11-21 20:15:06,837 - INFO - ydb.tests.library.harness.kikimr_runner.57987  - start: Started node localhost:30146/1
2025-11-21 20:15:06,838 - DEBUG - ya.test.57987  - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-21 20:15:06,839 - DEBUG - ya.test.57987  - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-21 20:15:06,840 - DEBUG - ya.test.57987  - execute: Executing '['/home/runner/.ya/build/build_root/tshh/002765/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-21 20:15:06,841 - DEBUG - ya.test.57987  - execute: Command pid: 59395
2025-11-21 20:15:07,584 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59395) rc: 0
2025-11-21 20:15:07,585 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59395) elapsed time (sec): 0.735640287399292
2025-11-21 20:15:07,585 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59395) idrss: 0
2025-11-21 20:15:07,585 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59395) inblock: 0
2025-11-21 20:15:07,586 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59395) isrss: 0
2025-11-21 20:15:07,586 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59395) ixrss: 0
2025-11-21 20:15:07,586 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59395) majflt: 0
2025-11-21 20:15:07,587 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59395) maxrss: 503544
2025-11-21 20:15:07,587 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59395) minflt: 45623
2025-11-21 20:15:07,587 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59395) msgrcv: 0
2025-11-21 20:15:07,588 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59395) msgsnd: 0
2025-11-21 20:15:07,588 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59395) nivcsw: 72
2025-11-21 20:15:07,588 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59395) nsignals: 0
2025-11-21 20:15:07,595 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59395) nswap: 0
2025-11-21 20:15:07,595 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59395) nvcsw: 15
2025-11-21 20:15:07,596 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59395) oublock: 8
2025-11-21 20:15:07,596 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59395) stime: 0.152058
2025-11-21 20:15:07,596 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59395) utime: 0.5223949999999999
2025-11-21 20:15:07,596 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59395) wtime: 0.737
2025-11-21 20:15:07,597 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59395) output:
Arc info:
    Branch: unknown-vcs-branch
    Commit: THIS_REVISION_IS_A_DUMMY
    Author: ordinal
    Summary: No VCS
    Last Changed Rev: -1
    Last Changed Date: 2015-03-14T06:05:35.000000Z
Other info:
    Build by: runner
    Top src dir: 
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-frzglb4yoy    Host information: 
        Linux ghrun-frzglb4yoy 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/10302026024/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10302026024/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-11-21 20:15:07,597 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 59395) errors:

2025-11-21 20:15:07,598 - INFO - ydb.tests.library.harness.kikimr_runner.57987  - start: Node 1 version:
Arc info:
    Branch: unknown-vcs-branch
    Commit: THIS_REVISION_IS_A_DUMMY
    Author: ordinal
    Summary: No VCS
    Last Changed Rev: -1
    Last Changed Date: 2015-03-14T06:05:35.000000Z
Other info:
    Build by: runner
    Top src dir: 
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-frzglb4yoy    Host information: 
        Linux ghrun-frzglb4yoy 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64
2025-11-21 20:15:12,423 - DEBUG - ya.test.57987  - get_binary: Binary was found by /home/runner/.ya/build/build_root/tshh/002765/ydb/apps/ydbd/ydbd
2025-11-21 20:15:12,424 - DEBUG - ydb.tests.library.harness.kikimr_runner.57987  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/tshh/002765/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:30146', '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: 8775\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-21 20:15:12,425 - DEBUG - ya.test.57987  - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-21 20:15:12,426 - DEBUG - ya.test.57987  - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-21 20:15:12,426 - DEBUG - ya.test.57987  - execute: Executing '['/home/runner/.ya/build/build_root/tshh/002765/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:30146', '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: 8775\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-21 20:15:12,427 - DEBUG - ya.test.57987  - execute: Command pid: 61108
2025-11-21 20:15:13,281 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61108) rc: 0
2025-11-21 20:15:13,281 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61108) elapsed time (sec): 0.8511955738067627
2025-11-21 20:15:13,282 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61108) idrss: 0
2025-11-21 20:15:13,282 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61108) inblock: 0
2025-11-21 20:15:13,282 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61108) isrss: 0
2025-11-21 20:15:13,282 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61108) ixrss: 0
2025-11-21 20:15:13,283 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61108) majflt: 0
2025-11-21 20:15:13,283 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61108) maxrss: 601712
2025-11-21 20:15:13,283 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61108) minflt: 51827
2025-11-21 20:15:13,284 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61108) msgrcv: 0
2025-11-21 20:15:13,284 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61108) msgsnd: 0
2025-11-21 20:15:13,284 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61108) nivcsw: 97
2025-11-21 20:15:13,285 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61108) nsignals: 0
2025-11-21 20:15:13,285 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61108) nswap: 0
2025-11-21 20:15:13,285 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61108) nvcsw: 723
2025-11-21 20:15:13,285 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61108) oublock: 8
2025-11-21 20:15:13,286 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61108) stime: 0.23776799999999998
2025-11-21 20:15:13,286 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61108) utime: 0.547885
2025-11-21 20:15:13,286 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61108) wtime: 0.853
2025-11-21 20:15:13,286 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61108) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-21 20:15:13,287 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61108) errors:

2025-11-21 20:15:13,289 - DEBUG - ya.test.57987  - get_binary: Binary was found by /home/runner/.ya/build/build_root/tshh/002765/ydb/apps/ydbd/ydbd
2025-11-21 20:15:13,289 - DEBUG - ydb.tests.library.harness.kikimr_runner.57987  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/tshh/002765/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:30146', '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-11-21 20:15:13,290 - DEBUG - ya.test.57987  - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-21 20:15:13,291 - DEBUG - ya.test.57987  - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-21 20:15:13,291 - DEBUG - ya.test.57987  - execute: Executing '['/home/runner/.ya/build/build_root/tshh/002765/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:30146', '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-11-21 20:15:13,293 - DEBUG - ya.test.57987  - execute: Command pid: 61465
2025-11-21 20:15:14,113 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61465) rc: 0
2025-11-21 20:15:14,113 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61465) elapsed time (sec): 0.811612606048584
2025-11-21 20:15:14,114 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61465) idrss: 0
2025-11-21 20:15:14,114 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61465) inblock: 0
2025-11-21 20:15:14,114 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61465) isrss: 0
2025-11-21 20:15:14,114 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61465) ixrss: 0
2025-11-21 20:15:14,115 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61465) majflt: 0
2025-11-21 20:15:14,115 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61465) maxrss: 602212
2025-11-21 20:15:14,115 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61465) minflt: 51849
2025-11-21 20:15:14,116 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61465) msgrcv: 0
2025-11-21 20:15:14,116 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61465) msgsnd: 0
2025-11-21 20:15:14,116 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61465) nivcsw: 73
2025-11-21 20:15:14,116 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61465) nsignals: 0
2025-11-21 20:15:14,117 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61465) nswap: 0
2025-11-21 20:15:14,117 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61465) nvcsw: 638
2025-11-21 20:15:14,117 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61465) oublock: 8
2025-11-21 20:15:14,117 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61465) stime: 0.271015
2025-11-21 20:15:14,118 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61465) utime: 0.48763399999999996
2025-11-21 20:15:14,118 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61465) wtime: 0.814
2025-11-21 20:15:14,118 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61465) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-11-21 20:15:14,118 - DEBUG - ya.test.57987  - _save_outputs: Command (pid 61465) errors:

2025-11-21 20:15:14,119 - INFO - ydb.tests.library.harness.kikimr_runner.57987  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-21 20:15:14,190 - INFO - ydb.tests.library.harness.kikimr_runner.57987  - __run: Cluster started and initialized
2025-11-21 20:15:14,218 - DEBUG - ydb.connection.57987  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-21 20:15:14,221 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.57987  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-21 20:15:14,223 - DEBUG - ydb.connection.57987  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-21 20:15:14,236 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.57987  - context_resolve: Resolving endpoints for database /Root
2025-11-21 20:15:14,237 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ListEndpoints, 7c807b94-8844-44b8-a265-b6d2f0099329, localhost:30146): creating call state
2025-11-21 20:15:14,237 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ListEndpoints, 7c807b94-8844-44b8-a265-b6d2f0099329, localhost:30146): request = { database: "/Root" }
2025-11-21 20:15:14,243 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ListEndpoints, 7c807b94-8844-44b8-a265-b6d2f0099329, localhost:30146): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-frzglb4yoy.auto.internal" port: 30146 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-11-21 20:15:14,245 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.57987  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-frzglb4yoy.auto.internal:30146, location 1, ssl: False>]>
2025-11-21 20:15:14,245 - DEBUG - ydb.connection.57987  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-21 20:15:14,256 - DEBUG - ydb.connection.57987  - close: Closing channel for endpoint localhost:30146
2025-11-21 20:15:14,256 - DEBUG - ydb.query.pool.57987  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-21 20:15:14,258 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(CreateSession, d14ea4ac-9bdd-45d3-a99c-180269f20729, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:14,258 - DEBUG - ydb.connection.57987  - _log_request: RpcState(CreateSession, d14ea4ac-9bdd-45d3-a99c-180269f20729, ghrun-frzglb4yoy.auto.internal:30146): request = {  }
2025-11-21 20:15:14,265 - DEBUG - ydb.connection.57987  - _log_response: RpcState(CreateSession, d14ea4ac-9bdd-45d3-a99c-180269f20729, ghrun-frzglb4yoy.auto.internal:30146): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" node_id: 1 }
2025-11-21 20:15:14,265 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(AttachSession, aa483e04-3648-4a40-9658-0df98cf95f21, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:14,266 - DEBUG - ydb.connection.57987  - _log_request: RpcState(AttachSession, aa483e04-3648-4a40-9658-0df98cf95f21, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" }
2025-11-21 20:15:14,268 - DEBUG - ydb.connection.57987  - _log_response: RpcState(AttachSession, aa483e04-3648-4a40-9658-0df98cf95f21, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:14,271 - DEBUG - ydb.query.pool.57987  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:14,272 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 336ec3a5-a44b-4096-b0eb-c28ae2061cbb, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:14,273 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 336ec3a5-a44b-4096-b0eb-c28ae2061cbb, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:14,274 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 336ec3a5-a44b-4096-b0eb-c28ae2061cbb, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:16,241 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:16,242 - INFO - __tests__.alter_compression.57987  - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-11-21 20:15:16,242 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:16,243 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, e0e7e110-6aea-4a73-8d7c-6c7acbb20508, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:16,244 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, e0e7e110-6aea-4a73-8d7c-6c7acbb20508, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:16,245 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, e0e7e110-6aea-4a73-8d7c-6c7acbb20508, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:17,226 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:17,227 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:17,227 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, d504e498-093a-472e-abc5-0222c24fa4d0, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:17,228 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, d504e498-093a-472e-abc5-0222c24fa4d0, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:17,229 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, d504e498-093a-472e-abc5-0222c24fa4d0, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:18,376 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:18,377 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:18,377 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 003006f2-7eda-4797-877b-b119dabf3c24, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:18,378 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 003006f2-7eda-4797-877b-b119dabf3c24, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:18,379 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 003006f2-7eda-4797-877b-b119dabf3c24, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:19,247 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:19,247 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:19,248 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, c4b40347-f8f2-4d1d-b114-ab6737f8453e, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:19,248 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, c4b40347-f8f2-4d1d-b114-ab6737f8453e, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:19,249 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, c4b40347-f8f2-4d1d-b114-ab6737f8453e, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:20,550 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:20,551 - INFO - __tests__.alter_compression.57987  - 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-11-21 20:15:20,551 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:20,552 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, e8d3ea0b-7db5-4818-b380-7a8cb967fbb0, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:20,553 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, e8d3ea0b-7db5-4818-b380-7a8cb967fbb0, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:20,554 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, e8d3ea0b-7db5-4818-b380-7a8cb967fbb0, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:21,292 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:21,293 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:21,294 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, a76d94e9-d2f6-411a-9ecb-424f505f6fbf, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:21,294 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, a76d94e9-d2f6-411a-9ecb-424f505f6fbf, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:21,296 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, a76d94e9-d2f6-411a-9ecb-424f505f6fbf, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:21,530 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:21,531 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:21,531 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 2ab000f6-a6e8-49e5-9399-3307f0d589bb, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:21,532 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 2ab000f6-a6e8-49e5-9399-3307f0d589bb, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:21,533 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 2ab000f6-a6e8-49e5-9399-3307f0d589bb, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:21,804 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:21,805 - INFO - __tests__.alter_compression.57987  - 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-11-21 20:15:21,805 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:21,806 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 4ccfdfd8-153f-4b18-ad7e-a863c18650cd, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:21,807 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 4ccfdfd8-153f-4b18-ad7e-a863c18650cd, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:21,808 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 4ccfdfd8-153f-4b18-ad7e-a863c18650cd, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:22,740 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:22,740 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:22,741 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 692148c8-8743-4cc7-94e1-e0b5f3e28b95, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:22,742 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 692148c8-8743-4cc7-94e1-e0b5f3e28b95, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:22,747 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 692148c8-8743-4cc7-94e1-e0b5f3e28b95, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:22,963 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:22,964 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:22,964 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, b458a7e8-a542-4fe7-89ba-509e50b3ff73, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:22,965 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, b458a7e8-a542-4fe7-89ba-509e50b3ff73, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:22,966 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, b458a7e8-a542-4fe7-89ba-509e50b3ff73, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:23,320 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:23,321 - INFO - __tests__.alter_compression.57987  - 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-11-21 20:15:23,321 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:23,322 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, b8365867-2ca1-4a6c-a8c4-732a7a84830f, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:23,323 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, b8365867-2ca1-4a6c-a8c4-732a7a84830f, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:23,324 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, b8365867-2ca1-4a6c-a8c4-732a7a84830f, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:24,266 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:24,266 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:24,267 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 5322509d-9fe1-4ef1-b987-960d12821703, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:24,267 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 5322509d-9fe1-4ef1-b987-960d12821703, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:24,268 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 5322509d-9fe1-4ef1-b987-960d12821703, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:24,566 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:24,567 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:24,568 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 80a5d59e-3347-49d6-afde-55f2e02d84d7, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:24,569 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 80a5d59e-3347-49d6-afde-55f2e02d84d7, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:24,570 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 80a5d59e-3347-49d6-afde-55f2e02d84d7, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:24,986 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:24,987 - INFO - __tests__.alter_compression.57987  - 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-11-21 20:15:24,987 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:24,988 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 26da1c10-07fd-4519-b532-72653dfc762f, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:24,988 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 26da1c10-07fd-4519-b532-72653dfc762f, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:24,989 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 26da1c10-07fd-4519-b532-72653dfc762f, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:26,073 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:26,074 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:26,074 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 4c771c92-7732-4abe-9ed2-654ad5eb0a6e, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:26,075 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 4c771c92-7732-4abe-9ed2-654ad5eb0a6e, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:26,077 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 4c771c92-7732-4abe-9ed2-654ad5eb0a6e, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:26,349 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:26,350 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:26,351 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 0195a9da-5c9b-462b-8651-71c475226c4d, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:26,352 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 0195a9da-5c9b-462b-8651-71c475226c4d, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:26,353 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 0195a9da-5c9b-462b-8651-71c475226c4d, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:26,803 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:26,803 - INFO - __tests__.alter_compression.57987  - 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-11-21 20:15:26,804 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:26,804 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 300456ac-7d23-4604-a22f-7badb2a41a5c, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:26,805 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 300456ac-7d23-4604-a22f-7badb2a41a5c, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:26,806 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 300456ac-7d23-4604-a22f-7badb2a41a5c, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:27,672 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:27,673 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:27,674 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, e6e94c83-3bd9-4937-8862-26f754b276cd, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:27,674 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, e6e94c83-3bd9-4937-8862-26f754b276cd, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:27,675 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, e6e94c83-3bd9-4937-8862-26f754b276cd, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:28,004 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:28,005 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:28,006 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 2af76ff0-0c48-4dd3-8385-b781ba6781c6, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:28,006 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 2af76ff0-0c48-4dd3-8385-b781ba6781c6, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:28,008 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 2af76ff0-0c48-4dd3-8385-b781ba6781c6, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:28,679 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:28,680 - INFO - __tests__.alter_compression.57987  - 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-11-21 20:15:28,680 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:28,681 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 070609c0-242b-4fe5-9c19-ffa01d4eb7ce, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:28,682 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 070609c0-242b-4fe5-9c19-ffa01d4eb7ce, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:28,687 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 070609c0-242b-4fe5-9c19-ffa01d4eb7ce, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:29,965 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:29,965 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:29,966 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, ad41adb0-e715-4a94-8909-cdba60f7ee60, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:29,967 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, ad41adb0-e715-4a94-8909-cdba60f7ee60, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:29,968 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, ad41adb0-e715-4a94-8909-cdba60f7ee60, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:30,315 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:30,316 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:30,317 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, ac3b29de-144c-4939-ac12-da61470c7181, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:30,317 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, ac3b29de-144c-4939-ac12-da61470c7181, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:30,319 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, ac3b29de-144c-4939-ac12-da61470c7181, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:30,824 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:30,825 - INFO - __tests__.alter_compression.57987  - 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-11-21 20:15:30,826 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:30,827 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 8e275097-2038-493a-b59c-d989d3859e2a, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:30,828 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 8e275097-2038-493a-b59c-d989d3859e2a, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:30,829 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 8e275097-2038-493a-b59c-d989d3859e2a, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:32,327 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:32,328 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:32,328 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 3fab36c0-f343-4430-b531-c4c9f8314411, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:32,329 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 3fab36c0-f343-4430-b531-c4c9f8314411, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:32,330 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 3fab36c0-f343-4430-b531-c4c9f8314411, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:32,718 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:32,719 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:32,719 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, e8003765-b8de-413d-9cc0-a8e0d8d63e3e, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:32,720 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, e8003765-b8de-413d-9cc0-a8e0d8d63e3e, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:32,723 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, e8003765-b8de-413d-9cc0-a8e0d8d63e3e, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:33,418 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:33,419 - INFO - __tests__.alter_compression.57987  - 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-11-21 20:15:33,419 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:33,420 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 30dfbc7f-1e97-49a9-a398-48c82667514f, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:33,421 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 30dfbc7f-1e97-49a9-a398-48c82667514f, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:33,424 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 30dfbc7f-1e97-49a9-a398-48c82667514f, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:35,415 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:35,416 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:35,416 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, b377974a-a862-4893-94da-b9a23b082bb4, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:35,417 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, b377974a-a862-4893-94da-b9a23b082bb4, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:35,418 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, b377974a-a862-4893-94da-b9a23b082bb4, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:36,008 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:36,009 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:36,010 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 6b762774-828e-4522-9f06-7818daadaed6, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:36,016 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 6b762774-828e-4522-9f06-7818daadaed6, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:36,017 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 6b762774-828e-4522-9f06-7818daadaed6, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:36,823 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:36,824 - INFO - __tests__.alter_compression.57987  - 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-11-21 20:15:36,825 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:36,825 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, ae3b350b-64f4-4783-834b-93c3fec14fcd, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:36,826 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, ae3b350b-64f4-4783-834b-93c3fec14fcd, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:36,828 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, ae3b350b-64f4-4783-834b-93c3fec14fcd, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:37,953 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:37,954 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:37,955 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, f513ae9d-6e1a-4c41-b199-120c7f5b3ce5, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:37,973 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, f513ae9d-6e1a-4c41-b199-120c7f5b3ce5, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:37,975 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, f513ae9d-6e1a-4c41-b199-120c7f5b3ce5, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:38,354 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:38,354 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:38,355 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 5c715ca8-9650-4698-9e8f-2da54d78a7b1, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:38,356 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 5c715ca8-9650-4698-9e8f-2da54d78a7b1, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:38,357 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 5c715ca8-9650-4698-9e8f-2da54d78a7b1, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:39,204 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:39,205 - INFO - __tests__.alter_compression.57987  - 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-11-21 20:15:39,206 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:39,206 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 2fd5ad52-6c75-4d89-9afc-6c97eb567afd, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:39,207 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 2fd5ad52-6c75-4d89-9afc-6c97eb567afd, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:39,209 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 2fd5ad52-6c75-4d89-9afc-6c97eb567afd, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:40,727 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:40,728 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:40,729 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 11865cd7-9af1-4bed-b420-ef3ad0adf386, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:40,729 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 11865cd7-9af1-4bed-b420-ef3ad0adf386, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:40,731 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 11865cd7-9af1-4bed-b420-ef3ad0adf386, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:41,207 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:41,208 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:41,209 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 466a480e-ed09-45da-bc0d-22a6091220b9, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:41,210 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 466a480e-ed09-45da-bc0d-22a6091220b9, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:41,213 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 466a480e-ed09-45da-bc0d-22a6091220b9, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:41,848 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:41,849 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:15:41,849 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, c32c43bb-ded2-4162-b1f9-194c3ab007b9, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:15:41,850 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, c32c43bb-ded2-4162-b1f9-194c3ab007b9, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:15:41,851 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, c32c43bb-ded2-4162-b1f9-194c3ab007b9, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:15:50,881 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:00,963 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:00,964 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 805f8e82-b6c8-43b7-91ad-239867f34696, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:16:00,965 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 805f8e82-b6c8-43b7-91ad-239867f34696, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:16:00,967 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 805f8e82-b6c8-43b7-91ad-239867f34696, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:16:08,554 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:08,603 - INFO - root.57987  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-21 20:16:08,604 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:08,605 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 8b4bbe82-fa3c-457c-b9fe-2abcf32d6e9a, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:16:08,606 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 8b4bbe82-fa3c-457c-b9fe-2abcf32d6e9a, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:16:08,607 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 8b4bbe82-fa3c-457c-b9fe-2abcf32d6e9a, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:16:14,638 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:21,477 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.57987  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-21 20:16:21,478 - DEBUG - ydb.connection.57987  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-21 20:16:21,486 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.57987  - context_resolve: Resolving endpoints for database /Root
2025-11-21 20:16:21,519 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ListEndpoints, 263c12ee-36cb-4f5f-ac32-d7de3863322b, localhost:30146): creating call state
2025-11-21 20:16:21,520 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ListEndpoints, 263c12ee-36cb-4f5f-ac32-d7de3863322b, localhost:30146): request = { database: "/Root" }
2025-11-21 20:16:21,525 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ListEndpoints, 263c12ee-36cb-4f5f-ac32-d7de3863322b, localhost:30146): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-frzglb4yoy.auto.internal" port: 30146 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-11-21 20:16:21,527 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.57987  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-frzglb4yoy.auto.internal:30146, location 1, ssl: False>]>
2025-11-21 20:16:21,528 - DEBUG - ydb.connection.57987  - close: Closing channel for endpoint localhost:30146
2025-11-21 20:16:24,693 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:24,694 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, af1f4816-d025-4006-8e66-f3a03a181926, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:16:24,697 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, af1f4816-d025-4006-8e66-f3a03a181926, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:16:24,698 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, af1f4816-d025-4006-8e66-f3a03a181926, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:16:26,458 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:36,465 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:36,466 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 571fb05e-0fc2-409d-8988-d0fdfa62a75b, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:16:36,467 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 571fb05e-0fc2-409d-8988-d0fdfa62a75b, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:16:36,469 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 571fb05e-0fc2-409d-8988-d0fdfa62a75b, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:16:37,552 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:47,557 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:47,558 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, d27e72c1-6005-408c-92ea-66278215eda8, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:16:47,559 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, d27e72c1-6005-408c-92ea-66278215eda8, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:16:47,561 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, d27e72c1-6005-408c-92ea-66278215eda8, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:16:48,271 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:48,275 - INFO - root.57987  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8009216)
2025-11-21 20:16:48,276 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:48,277 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 2655bd26-29bf-4a96-b8ab-23eb3ac9ab37, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:16:48,277 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 2655bd26-29bf-4a96-b8ab-23eb3ac9ab37, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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 }
2025-11-21 20:16:48,279 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 2655bd26-29bf-4a96-b8ab-23eb3ac9ab37, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:16:48,552 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:48,556 - INFO - ya.test.57987  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_4_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 4])
2025-11-21 20:16:48,557 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:48,558 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, ee0d1020-3a47-4c8a-9422-8abc652c7fd9, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:16:48,559 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, ee0d1020-3a47-4c8a-9422-8abc652c7fd9, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_4_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 4)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:16:48,560 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, ee0d1020-3a47-4c8a-9422-8abc652c7fd9, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:16:51,732 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:51,732 - INFO - __tests__.alter_compression.57987  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_4_compression created
2025-11-21 20:16:51,733 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:51,734 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 610d6c26-2c1c-45ef-8810-e3c435026622, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:16:51,734 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 610d6c26-2c1c-45ef-8810-e3c435026622, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_4_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:16:51,736 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 610d6c26-2c1c-45ef-8810-e3c435026622, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:16:52,560 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:52,561 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:52,561 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 7084253a-5921-468a-a7a2-09545472d619, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:16:52,562 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 7084253a-5921-468a-a7a2-09545472d619, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:16:52,563 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 7084253a-5921-468a-a7a2-09545472d619, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:16:54,058 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:54,059 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:54,059 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, aabf58c3-8652-4fe6-88f8-8e3a6ab06ff3, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:16:54,060 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, aabf58c3-8652-4fe6-88f8-8e3a6ab06ff3, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:16:54,061 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, aabf58c3-8652-4fe6-88f8-8e3a6ab06ff3, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:16:54,890 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:54,891 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:54,891 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, d45312b4-0523-422d-b309-82a49072f088, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:16:54,892 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, d45312b4-0523-422d-b309-82a49072f088, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:16:54,897 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, d45312b4-0523-422d-b309-82a49072f088, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:16:56,696 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:56,697 - INFO - __tests__.alter_compression.57987  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318960, 'BlobCount': 128}}
2025-11-21 20:16:56,697 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:56,698 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 21b2436b-4757-4613-8030-53ca20debadc, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:16:56,698 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 21b2436b-4757-4613-8030-53ca20debadc, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:16:56,700 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 21b2436b-4757-4613-8030-53ca20debadc, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:16:57,728 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:57,729 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:57,729 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, c9ed7335-d06e-417a-b002-1e4e4767991b, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:16:57,730 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, c9ed7335-d06e-417a-b002-1e4e4767991b, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:16:57,732 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, c9ed7335-d06e-417a-b002-1e4e4767991b, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:16:58,039 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:58,040 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:58,041 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 3c5e3d4c-ce55-40e1-93e9-feef35ba9a94, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:16:58,041 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 3c5e3d4c-ce55-40e1-93e9-feef35ba9a94, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:16:58,049 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 3c5e3d4c-ce55-40e1-93e9-feef35ba9a94, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:16:58,372 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:58,372 - INFO - __tests__.alter_compression.57987  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 638256, 'BlobCount': 256}}
2025-11-21 20:16:58,373 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:58,373 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, fd00843d-68ca-47b1-b31e-bac8d82d49a7, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:16:58,374 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, fd00843d-68ca-47b1-b31e-bac8d82d49a7, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:16:58,376 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, fd00843d-68ca-47b1-b31e-bac8d82d49a7, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:16:59,498 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:59,499 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:59,499 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 7a3791bb-0d82-45ab-bcfe-ce45498d122b, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:16:59,500 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 7a3791bb-0d82-45ab-bcfe-ce45498d122b, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:16:59,501 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 7a3791bb-0d82-45ab-bcfe-ce45498d122b, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:16:59,753 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:59,754 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:16:59,754 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 69ba7340-315e-4c37-b5ce-3d7620c6b038, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:16:59,755 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 69ba7340-315e-4c37-b5ce-3d7620c6b038, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:16:59,756 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 69ba7340-315e-4c37-b5ce-3d7620c6b038, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:00,173 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:00,174 - INFO - __tests__.alter_compression.57987  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 957296, 'BlobCount': 384}}
2025-11-21 20:17:00,175 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:00,175 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 3138773c-a746-4bba-8d74-86b9d82c82c2, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:17:00,176 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 3138773c-a746-4bba-8d74-86b9d82c82c2, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:17:00,177 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 3138773c-a746-4bba-8d74-86b9d82c82c2, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:01,535 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:01,536 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:01,536 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, ca5444ba-5c9c-49e2-98a8-270cb633182f, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:17:01,537 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, ca5444ba-5c9c-49e2-98a8-270cb633182f, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:17:01,540 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, ca5444ba-5c9c-49e2-98a8-270cb633182f, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:01,794 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:01,795 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:01,796 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, ece7a07d-2569-425c-b67f-4c28b4f4f81c, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:17:01,796 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, ece7a07d-2569-425c-b67f-4c28b4f4f81c, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:17:01,797 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, ece7a07d-2569-425c-b67f-4c28b4f4f81c, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:02,247 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:02,248 - INFO - __tests__.alter_compression.57987  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1276656, 'BlobCount': 512}}
2025-11-21 20:17:02,248 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:02,249 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, cce243f8-9346-40f6-ba73-93351696dd80, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:17:02,250 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, cce243f8-9346-40f6-ba73-93351696dd80, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:17:02,252 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, cce243f8-9346-40f6-ba73-93351696dd80, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:03,512 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:03,513 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:03,514 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 74e61996-c6c4-4040-94c0-6fe87aed9164, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:17:03,515 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 74e61996-c6c4-4040-94c0-6fe87aed9164, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:17:03,516 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 74e61996-c6c4-4040-94c0-6fe87aed9164, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:03,792 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:03,793 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:03,794 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 6cba99e8-d2bf-428f-9092-03a34fcfa519, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:17:03,795 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 6cba99e8-d2bf-428f-9092-03a34fcfa519, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:17:03,797 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 6cba99e8-d2bf-428f-9092-03a34fcfa519, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:04,402 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:04,403 - INFO - __tests__.alter_compression.57987  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1595616, 'BlobCount': 640}}
2025-11-21 20:17:04,404 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:04,404 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 0b1e6281-e858-4cf1-891e-dbf4ddc4f823, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:17:04,405 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 0b1e6281-e858-4cf1-891e-dbf4ddc4f823, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:17:04,409 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 0b1e6281-e858-4cf1-891e-dbf4ddc4f823, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:05,587 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:05,587 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:05,588 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, c6e4b08b-c60d-471b-ad48-38ed731c1328, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:17:05,589 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, c6e4b08b-c60d-471b-ad48-38ed731c1328, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:17:05,590 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, c6e4b08b-c60d-471b-ad48-38ed731c1328, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:05,836 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:05,837 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:05,838 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 426a9c5f-b1a7-4725-8e76-a112445a2582, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:17:05,839 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 426a9c5f-b1a7-4725-8e76-a112445a2582, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:17:05,840 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 426a9c5f-b1a7-4725-8e76-a112445a2582, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:06,363 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:06,364 - INFO - __tests__.alter_compression.57987  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1914800, 'BlobCount': 768}}
2025-11-21 20:17:06,364 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:06,365 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 1aeafb7f-075e-4ef8-95e8-0c57782e54d5, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:17:06,366 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 1aeafb7f-075e-4ef8-95e8-0c57782e54d5, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:17:06,367 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 1aeafb7f-075e-4ef8-95e8-0c57782e54d5, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:07,671 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:07,672 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:07,672 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 857f51ab-32da-4cce-8abe-463474cb18d0, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:17:07,673 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 857f51ab-32da-4cce-8abe-463474cb18d0, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:17:07,675 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 857f51ab-32da-4cce-8abe-463474cb18d0, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:07,982 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:07,983 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:07,984 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 5fd8f8ce-b4da-4ec8-9403-d0a91666fc24, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:17:07,985 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 5fd8f8ce-b4da-4ec8-9403-d0a91666fc24, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:17:07,989 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 5fd8f8ce-b4da-4ec8-9403-d0a91666fc24, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:08,628 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:08,629 - INFO - __tests__.alter_compression.57987  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2233936, 'BlobCount': 896}}
2025-11-21 20:17:08,629 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:08,630 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 9dd43f2a-6cda-4344-b26a-6155c81a3b75, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:17:08,631 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 9dd43f2a-6cda-4344-b26a-6155c81a3b75, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:17:08,633 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 9dd43f2a-6cda-4344-b26a-6155c81a3b75, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:09,863 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:09,864 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:09,864 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 3804f4c5-e8e8-4697-9bb1-ee207f82c5f0, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:17:09,865 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 3804f4c5-e8e8-4697-9bb1-ee207f82c5f0, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:17:09,867 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 3804f4c5-e8e8-4697-9bb1-ee207f82c5f0, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:10,102 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:10,159 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:10,160 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, ecc53be9-d67c-4eb1-9786-46ad20a3db5a, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:17:10,161 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, ecc53be9-d67c-4eb1-9786-46ad20a3db5a, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:17:10,162 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, ecc53be9-d67c-4eb1-9786-46ad20a3db5a, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:10,783 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:10,784 - INFO - __tests__.alter_compression.57987  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2553424, 'BlobCount': 1024}}
2025-11-21 20:17:10,784 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:10,785 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 4eab9645-b48b-4947-9df4-d11c213299bf, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:17:10,786 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 4eab9645-b48b-4947-9df4-d11c213299bf, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:17:10,788 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 4eab9645-b48b-4947-9df4-d11c213299bf, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:12,367 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:12,368 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:12,369 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 2f7b3720-4940-48b2-a7f7-c865fae436a0, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:17:12,369 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 2f7b3720-4940-48b2-a7f7-c865fae436a0, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:17:12,371 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 2f7b3720-4940-48b2-a7f7-c865fae436a0, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:12,809 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:12,810 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:12,811 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 1f6f7ae2-ba71-476a-a737-43e887fc7d6f, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:17:12,811 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 1f6f7ae2-ba71-476a-a737-43e887fc7d6f, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:17:12,813 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 1f6f7ae2-ba71-476a-a737-43e887fc7d6f, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:13,620 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:13,621 - INFO - __tests__.alter_compression.57987  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2872432, 'BlobCount': 1152}}
2025-11-21 20:17:13,621 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:13,622 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 6e405127-9bcc-478a-9d67-7128a6218eff, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:17:13,623 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 6e405127-9bcc-478a-9d67-7128a6218eff, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:17:13,624 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 6e405127-9bcc-478a-9d67-7128a6218eff, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:14,836 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:14,836 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:14,837 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 8f79c39a-bf47-435d-884a-7d124d0f144e, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:17:14,838 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 8f79c39a-bf47-435d-884a-7d124d0f144e, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:17:14,839 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 8f79c39a-bf47-435d-884a-7d124d0f144e, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:15,303 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:15,304 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:15,305 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 2f83f72d-e2f2-4bae-98c1-94a0a6508cd2, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:17:15,306 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 2f83f72d-e2f2-4bae-98c1-94a0a6508cd2, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:17:15,308 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 2f83f72d-e2f2-4bae-98c1-94a0a6508cd2, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:16,931 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:16,932 - INFO - __tests__.alter_compression.57987  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3191936, 'BlobCount': 1280}}
2025-11-21 20:17:16,935 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:16,938 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 36fbda74-03b8-46ad-be6f-757294dd6e07, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:17:16,946 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 36fbda74-03b8-46ad-be6f-757294dd6e07, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_4_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:17:16,955 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 36fbda74-03b8-46ad-be6f-757294dd6e07, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:18,931 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:18,932 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:18,933 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, c4bb75b5-28ec-47e7-a87b-d98821fbd0e1, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:17:18,934 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, c4bb75b5-28ec-47e7-a87b-d98821fbd0e1, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:17:18,936 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, c4bb75b5-28ec-47e7-a87b-d98821fbd0e1, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:19,326 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:19,327 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:19,328 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 5d41ccc9-92ef-4b31-b7d9-fea2265b1fb2, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:17:19,329 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 5d41ccc9-92ef-4b31-b7d9-fea2265b1fb2, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:17:19,333 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 5d41ccc9-92ef-4b31-b7d9-fea2265b1fb2, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:19,773 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:19,774 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:19,774 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, cf70c2d8-6652-42c3-b14b-4cf139101997, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:17:19,775 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, cf70c2d8-6652-42c3-b14b-4cf139101997, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:17:19,777 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, cf70c2d8-6652-42c3-b14b-4cf139101997, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:24,213 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:34,256 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:34,257 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, dc014d1e-d597-419f-b79e-b8d8b8b1b585, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:17:34,258 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, dc014d1e-d597-419f-b79e-b8d8b8b1b585, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:17:34,259 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, dc014d1e-d597-419f-b79e-b8d8b8b1b585, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:39,604 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:39,674 - INFO - root.57987  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_4_compression`, volumes `value` (8000000, 1595968)
2025-11-21 20:17:39,676 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:39,677 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, b2dc4c8f-aceb-4144-9316-f559f7d734c6, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:17:39,678 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, b2dc4c8f-aceb-4144-9316-f559f7d734c6, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:17:39,681 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, b2dc4c8f-aceb-4144-9316-f559f7d734c6, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:40,299 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:40,300 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:40,301 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 9286f605-3de8-4d72-8c05-ac1ed473041d, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:17:40,302 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 9286f605-3de8-4d72-8c05-ac1ed473041d, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:17:40,312 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 9286f605-3de8-4d72-8c05-ac1ed473041d, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:46,424 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:55,679 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.57987  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-21 20:17:55,679 - DEBUG - ydb.connection.57987  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-21 20:17:55,692 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.57987  - context_resolve: Resolving endpoints for database /Root
2025-11-21 20:17:55,693 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ListEndpoints, c343d73d-dd46-4af3-821c-e5a486f32abb, localhost:30146): creating call state
2025-11-21 20:17:55,694 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ListEndpoints, c343d73d-dd46-4af3-821c-e5a486f32abb, localhost:30146): request = { database: "/Root" }
2025-11-21 20:17:55,699 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ListEndpoints, c343d73d-dd46-4af3-821c-e5a486f32abb, localhost:30146): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-frzglb4yoy.auto.internal" port: 30146 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-11-21 20:17:55,699 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.57987  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-frzglb4yoy.auto.internal:30146, location 1, ssl: False>]>
2025-11-21 20:17:55,700 - DEBUG - ydb.connection.57987  - close: Closing channel for endpoint localhost:30146
2025-11-21 20:17:56,490 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:17:56,491 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, dca422f0-9347-460c-b438-3d56091d72d9, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:17:56,491 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, dca422f0-9347-460c-b438-3d56091d72d9, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:17:56,493 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, dca422f0-9347-460c-b438-3d56091d72d9, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:17:58,311 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:18:08,326 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:18:08,327 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, 8fa5abd0-297e-4583-a080-82040d367c2d, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:18:08,328 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, 8fa5abd0-297e-4583-a080-82040d367c2d, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:18:08,329 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, 8fa5abd0-297e-4583-a080-82040d367c2d, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:18:08,956 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:18:18,963 - DEBUG - ydb.query.pool.57987  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:18:18,964 - DEBUG - ydb.connection.57987  - _prepare_call: RpcState(ExecuteQuery, e6e85c3d-fcc5-4172-a115-e750c4f95f5a, ghrun-frzglb4yoy.auto.internal:30146): creating call state
2025-11-21 20:18:18,964 - DEBUG - ydb.connection.57987  - _log_request: RpcState(ExecuteQuery, e6e85c3d-fcc5-4172-a115-e750c4f95f5a, ghrun-frzglb4yoy.auto.internal:30146): request = { session_id: "ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:18:18,966 - DEBUG - ydb.connection.57987  - _log_response: RpcState(ExecuteQuery, e6e85c3d-fcc5-4172-a115-e750c4f95f5a, ghrun-frzglb4yoy.auto.internal:30146): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:18:19,891 - DEBUG - ydb.query.pool.57987  - release: Session returned to queue: ydb://session/3?node_id=1&id=MmIzMWY3ZjEtYTY5ODUzZTctZmEyMzg0ZDMtYzdmNzg1YzA=
2025-11-21 20:18:19,942 - INFO - root.57987  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_4_compression`, volumes `value` (8000000, 1466456)
2025-11-21 20:18:19,944 - INFO - root.57987  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_4_compression` 8092160 / 1466456: 5.518174428690666
2025-11-21 20:18:19,964 - INFO - ya.test.57987  - pytest_runtest_teardown: Test teardown
