2025-11-21 14:05:56,128 - INFO - ya.test.1142858  - pytest_runtest_setup: ####################################################################################################
2025-11-21 14:05:56,129 - INFO - ya.test.1142858  - pytest_runtest_setup: test_all_supported_compression[zstd_18_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 18]
2025-11-21 14:05:56,129 - INFO - ya.test.1142858  - pytest_runtest_setup: ####################################################################################################
2025-11-21 14:05:56,129 - INFO - ya.test.1142858  - pytest_runtest_setup: Test setup
2025-11-21 14:05:56,132 - DEBUG - ya.test.1142858  - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-21 14:05:56,134 - DEBUG - ya.test.1142858  - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-21 14:05:56,134 - DEBUG - ya.test.1142858  - execute: Executing '['/home/runner/.ya/build/build_root/evw0/005d93/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-21 14:05:56,147 - DEBUG - ya.test.1142858  - execute: Command pid: 1144970
2025-11-21 14:05:57,092 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1144970) rc: 0
2025-11-21 14:05:57,093 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1144970) elapsed time (sec): 0.9429528713226318
2025-11-21 14:05:57,093 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1144970) idrss: 0
2025-11-21 14:05:57,093 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1144970) inblock: 0
2025-11-21 14:05:57,094 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1144970) isrss: 0
2025-11-21 14:05:57,094 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1144970) ixrss: 0
2025-11-21 14:05:57,094 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1144970) majflt: 0
2025-11-21 14:05:57,095 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1144970) maxrss: 488932
2025-11-21 14:05:57,095 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1144970) minflt: 45625
2025-11-21 14:05:57,095 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1144970) msgrcv: 0
2025-11-21 14:05:57,095 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1144970) msgsnd: 0
2025-11-21 14:05:57,096 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1144970) nivcsw: 115
2025-11-21 14:05:57,096 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1144970) nsignals: 0
2025-11-21 14:05:57,096 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1144970) nswap: 0
2025-11-21 14:05:57,096 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1144970) nvcsw: 14
2025-11-21 14:05:57,097 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1144970) oublock: 8
2025-11-21 14:05:57,097 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1144970) stime: 0.23632599999999998
2025-11-21 14:05:57,097 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1144970) utime: 0.534137
2025-11-21 14:05:57,098 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1144970) wtime: 0.957
2025-11-21 14:05:57,098 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1144970) 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-acwccf6kvy    Host information: 
        Linux ghrun-acwccf6kvy 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 14:05:57,098 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1144970) errors:

2025-11-21 14:05:57,099 - INFO - __tests__.base.1142858  - _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-acwccf6kvy    Host information: 
        Linux ghrun-acwccf6kvy 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 14:05:57,250 - DEBUG - ya.test.1142858  - get_binary: Binary was found by /home/runner/.ya/build/build_root/evw0/005d93/ydb/apps/ydbd/ydbd
2025-11-21 14:05:57,252 - DEBUG - library.python.filelock.1142858  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/2734
2025-11-21 14:05:57,254 - DEBUG - ydb.tests.library.harness.kikimr_runner.1142858  - start: Working directory: /home/runner/.ya/build/build_root/evw0/005d93/r3tmp/kikimr_cluster_147_twgp
2025-11-21 14:05:57,303 - DEBUG - ya.test.1142858  - get_binary: Binary was found by /home/runner/.ya/build/build_root/evw0/005d93/ydb/apps/ydbd/ydbd
2025-11-21 14:05:57,304 - DEBUG - library.python.filelock.1142858  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/22973
2025-11-21 14:05:57,304 - DEBUG - library.python.filelock.1142858  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/1101
2025-11-21 14:05:57,305 - DEBUG - library.python.filelock.1142858  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/17921
2025-11-21 14:05:57,305 - DEBUG - library.python.filelock.1142858  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/4899
2025-11-21 14:05:57,307 - INFO - ydb.tests.library.harness.kikimr_runner.1142858  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/evw0/005d93/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk3/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_18_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.18/cluster/kikimr_configs"
2025-11-21 14:05:57,307 - INFO - ydb.tests.library.harness.kikimr_runner.1142858  - __make_run_command: Final command: /home/runner/.ya/build/build_root/evw0/005d93/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/evw0/005d93/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk3/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_18_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.18/cluster/node_1/logfile_wixgaaoc.log --grpc-port=22973 --mon-port=1101 --ic-port=2734
2025-11-21 14:05:57,308 - DEBUG - ydb.tests.library.harness.kikimr_runner.1142858  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:22973/1, disk_size 68719476736
2025-11-21 14:05:57,308 - INFO - ydb.tests.library.harness.kikimr_runner.1142858  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/evw0/005d93/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk3/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_18_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.18/cluster/kikimr_configs"
2025-11-21 14:05:57,309 - INFO - ydb.tests.library.harness.kikimr_runner.1142858  - __make_run_command: Final command: /home/runner/.ya/build/build_root/evw0/005d93/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/evw0/005d93/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk3/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_18_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.18/cluster/node_1/logfile_wixgaaoc.log --grpc-port=22973 --mon-port=1101 --ic-port=2734
2025-11-21 14:05:57,310 - DEBUG - ya.test.1142858  - execute: Executing '('/home/runner/.ya/build/build_root/evw0/005d93/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/evw0/005d93/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk3/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_18_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.18/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/evw0/005d93/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk3/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_18_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.18/cluster/node_1/logfile_wixgaaoc.log', '--grpc-port=22973', '--mon-port=1101', '--ic-port=2734')' in '/home/runner/.ya/build/build_root/evw0/005d93/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk3/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_18_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.18/cluster/node_1' (no wait)
2025-11-21 14:05:57,314 - DEBUG - ya.test.1142858  - execute: Command pid: 1145402
2025-11-21 14:05:57,315 - INFO - ydb.tests.library.harness.kikimr_runner.1142858  - start: Started node localhost:22973/1
2025-11-21 14:05:57,317 - DEBUG - ya.test.1142858  - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-21 14:05:57,317 - DEBUG - ya.test.1142858  - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-21 14:05:57,318 - DEBUG - ya.test.1142858  - execute: Executing '['/home/runner/.ya/build/build_root/evw0/005d93/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-21 14:05:57,320 - DEBUG - ya.test.1142858  - execute: Command pid: 1145403
2025-11-21 14:05:58,259 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1145403) rc: 0
2025-11-21 14:05:58,260 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1145403) elapsed time (sec): 0.9304039478302002
2025-11-21 14:05:58,260 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1145403) idrss: 0
2025-11-21 14:05:58,260 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1145403) inblock: 0
2025-11-21 14:05:58,261 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1145403) isrss: 0
2025-11-21 14:05:58,261 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1145403) ixrss: 0
2025-11-21 14:05:58,261 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1145403) majflt: 0
2025-11-21 14:05:58,262 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1145403) maxrss: 499140
2025-11-21 14:05:58,262 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1145403) minflt: 45607
2025-11-21 14:05:58,262 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1145403) msgrcv: 0
2025-11-21 14:05:58,262 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1145403) msgsnd: 0
2025-11-21 14:05:58,264 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1145403) nivcsw: 177
2025-11-21 14:05:58,264 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1145403) nsignals: 0
2025-11-21 14:05:58,265 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1145403) nswap: 0
2025-11-21 14:05:58,265 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1145403) nvcsw: 13
2025-11-21 14:05:58,265 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1145403) oublock: 8
2025-11-21 14:05:58,266 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1145403) stime: 0.24550999999999998
2025-11-21 14:05:58,266 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1145403) utime: 0.5587059999999999
2025-11-21 14:05:58,266 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1145403) wtime: 0.933
2025-11-21 14:05:58,267 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1145403) 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-acwccf6kvy    Host information: 
        Linux ghrun-acwccf6kvy 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 14:05:58,267 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1145403) errors:

2025-11-21 14:05:58,275 - INFO - ydb.tests.library.harness.kikimr_runner.1142858  - 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-acwccf6kvy    Host information: 
        Linux ghrun-acwccf6kvy 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64
2025-11-21 14:06:03,775 - DEBUG - ya.test.1142858  - get_binary: Binary was found by /home/runner/.ya/build/build_root/evw0/005d93/ydb/apps/ydbd/ydbd
2025-11-21 14:06:03,775 - DEBUG - ydb.tests.library.harness.kikimr_runner.1142858  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/evw0/005d93/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:22973', '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: 2734\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-21 14:06:03,777 - DEBUG - ya.test.1142858  - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-21 14:06:03,777 - DEBUG - ya.test.1142858  - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-21 14:06:03,778 - DEBUG - ya.test.1142858  - execute: Executing '['/home/runner/.ya/build/build_root/evw0/005d93/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:22973', '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: 2734\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-21 14:06:03,791 - DEBUG - ya.test.1142858  - execute: Command pid: 1146589
2025-11-21 14:06:05,354 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1146589) rc: 0
2025-11-21 14:06:05,354 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1146589) elapsed time (sec): 1.561657190322876
2025-11-21 14:06:05,355 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1146589) idrss: 0
2025-11-21 14:06:05,355 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1146589) inblock: 0
2025-11-21 14:06:05,355 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1146589) isrss: 0
2025-11-21 14:06:05,356 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1146589) ixrss: 0
2025-11-21 14:06:05,356 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1146589) majflt: 0
2025-11-21 14:06:05,356 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1146589) maxrss: 594456
2025-11-21 14:06:05,356 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1146589) minflt: 51896
2025-11-21 14:06:05,357 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1146589) msgrcv: 0
2025-11-21 14:06:05,357 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1146589) msgsnd: 0
2025-11-21 14:06:05,357 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1146589) nivcsw: 243
2025-11-21 14:06:05,358 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1146589) nsignals: 0
2025-11-21 14:06:05,358 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1146589) nswap: 0
2025-11-21 14:06:05,358 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1146589) nvcsw: 535
2025-11-21 14:06:05,358 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1146589) oublock: 8
2025-11-21 14:06:05,365 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1146589) stime: 0.34679699999999997
2025-11-21 14:06:05,365 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1146589) utime: 0.6220939999999999
2025-11-21 14:06:05,365 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1146589) wtime: 1.575
2025-11-21 14:06:05,366 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1146589) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-21 14:06:05,366 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1146589) errors:

2025-11-21 14:06:05,367 - DEBUG - ya.test.1142858  - get_binary: Binary was found by /home/runner/.ya/build/build_root/evw0/005d93/ydb/apps/ydbd/ydbd
2025-11-21 14:06:05,368 - DEBUG - ydb.tests.library.harness.kikimr_runner.1142858  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/evw0/005d93/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:22973', '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 14:06:05,369 - DEBUG - ya.test.1142858  - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-21 14:06:05,370 - DEBUG - ya.test.1142858  - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-21 14:06:05,371 - DEBUG - ya.test.1142858  - execute: Executing '['/home/runner/.ya/build/build_root/evw0/005d93/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:22973', '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 14:06:05,396 - DEBUG - ya.test.1142858  - execute: Command pid: 1147099
2025-11-21 14:06:06,589 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1147099) rc: 0
2025-11-21 14:06:06,589 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1147099) elapsed time (sec): 1.190131664276123
2025-11-21 14:06:06,590 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1147099) idrss: 0
2025-11-21 14:06:06,590 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1147099) inblock: 0
2025-11-21 14:06:06,590 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1147099) isrss: 0
2025-11-21 14:06:06,590 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1147099) ixrss: 0
2025-11-21 14:06:06,591 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1147099) majflt: 0
2025-11-21 14:06:06,591 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1147099) maxrss: 594676
2025-11-21 14:06:06,591 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1147099) minflt: 51978
2025-11-21 14:06:06,592 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1147099) msgrcv: 0
2025-11-21 14:06:06,592 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1147099) msgsnd: 0
2025-11-21 14:06:06,592 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1147099) nivcsw: 196
2025-11-21 14:06:06,593 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1147099) nsignals: 0
2025-11-21 14:06:06,593 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1147099) nswap: 0
2025-11-21 14:06:06,593 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1147099) nvcsw: 530
2025-11-21 14:06:06,593 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1147099) oublock: 8
2025-11-21 14:06:06,594 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1147099) stime: 0.276385
2025-11-21 14:06:06,594 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1147099) utime: 0.582822
2025-11-21 14:06:06,594 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1147099) wtime: 1.216
2025-11-21 14:06:06,599 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1147099) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-11-21 14:06:06,599 - DEBUG - ya.test.1142858  - _save_outputs: Command (pid 1147099) errors:

2025-11-21 14:06:06,600 - INFO - ydb.tests.library.harness.kikimr_runner.1142858  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-21 14:06:06,706 - INFO - ydb.tests.library.harness.kikimr_runner.1142858  - __run: Cluster started and initialized
2025-11-21 14:06:06,778 - DEBUG - ydb.connection.1142858  - 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 14:06:06,784 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1142858  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-21 14:06:06,787 - DEBUG - ydb.connection.1142858  - 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 14:06:06,829 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1142858  - context_resolve: Resolving endpoints for database /Root
2025-11-21 14:06:06,830 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ListEndpoints, a82bcba9-0565-420a-acfc-1360b9347047, localhost:22973): creating call state
2025-11-21 14:06:06,831 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ListEndpoints, a82bcba9-0565-420a-acfc-1360b9347047, localhost:22973): request = { database: "/Root" }
2025-11-21 14:06:06,841 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ListEndpoints, a82bcba9-0565-420a-acfc-1360b9347047, localhost:22973): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-acwccf6kvy.auto.internal" port: 22973 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 14:06:06,843 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1142858  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-acwccf6kvy.auto.internal:22973, location 1, ssl: False>]>
2025-11-21 14:06:06,844 - DEBUG - ydb.connection.1142858  - 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 14:06:06,877 - DEBUG - ydb.connection.1142858  - close: Closing channel for endpoint localhost:22973
2025-11-21 14:06:06,878 - DEBUG - ydb.query.pool.1142858  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-21 14:06:06,880 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(CreateSession, 1e417d80-b176-45cb-b52e-ab5f54cb1416, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:06,881 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(CreateSession, 1e417d80-b176-45cb-b52e-ab5f54cb1416, ghrun-acwccf6kvy.auto.internal:22973): request = {  }
2025-11-21 14:06:06,892 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(CreateSession, 1e417d80-b176-45cb-b52e-ab5f54cb1416, ghrun-acwccf6kvy.auto.internal:22973): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" node_id: 1 }
2025-11-21 14:06:06,893 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(AttachSession, fa14ae84-f105-4585-ba8b-2936bd33e384, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:06,894 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(AttachSession, fa14ae84-f105-4585-ba8b-2936bd33e384, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" }
2025-11-21 14:06:06,901 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(AttachSession, fa14ae84-f105-4585-ba8b-2936bd33e384, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:06,943 - DEBUG - ydb.query.pool.1142858  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:06,944 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, b830b156-46ef-4d48-9889-23a0a461d906, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:06,945 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, b830b156-46ef-4d48-9889-23a0a461d906, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:06,946 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, b830b156-46ef-4d48-9889-23a0a461d906, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:11,125 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:11,259 - INFO - __tests__.alter_compression.1142858  - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-11-21 14:06:11,260 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:11,261 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, e9adfd0f-54ed-45fa-9c0a-25e0d902d117, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:11,262 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, e9adfd0f-54ed-45fa-9c0a-25e0d902d117, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:11,264 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, e9adfd0f-54ed-45fa-9c0a-25e0d902d117, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:12,665 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:12,666 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:12,667 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, b35e1620-d2d6-4aa4-9f34-132879e792ef, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:12,668 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, b35e1620-d2d6-4aa4-9f34-132879e792ef, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:12,670 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, b35e1620-d2d6-4aa4-9f34-132879e792ef, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:13,687 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:13,688 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:13,688 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, c5302490-821e-4143-b60a-f796629dd5fd, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:13,689 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, c5302490-821e-4143-b60a-f796629dd5fd, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:13,690 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, c5302490-821e-4143-b60a-f796629dd5fd, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:14,405 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:14,406 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:14,407 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 4ed742b7-6aa1-4c8a-a0e0-56debd28b53d, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:14,408 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 4ed742b7-6aa1-4c8a-a0e0-56debd28b53d, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:14,410 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 4ed742b7-6aa1-4c8a-a0e0-56debd28b53d, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:16,779 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:16,780 - INFO - __tests__.alter_compression.1142858  - 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 14:06:16,781 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:16,781 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 1c4c11b3-206a-4a23-9712-920c2c9b9dc9, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:16,782 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 1c4c11b3-206a-4a23-9712-920c2c9b9dc9, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:16,784 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 1c4c11b3-206a-4a23-9712-920c2c9b9dc9, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:18,206 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:18,206 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:18,207 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 83b9d5cb-0dbd-48c3-943d-65554be6404b, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:18,208 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 83b9d5cb-0dbd-48c3-943d-65554be6404b, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:18,209 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 83b9d5cb-0dbd-48c3-943d-65554be6404b, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:18,595 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:18,596 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:18,604 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 0dd8422d-676a-4ea2-ba07-f9e83156d510, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:18,605 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 0dd8422d-676a-4ea2-ba07-f9e83156d510, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:18,607 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 0dd8422d-676a-4ea2-ba07-f9e83156d510, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:19,068 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:19,069 - INFO - __tests__.alter_compression.1142858  - 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 14:06:19,070 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:19,070 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 8e3ef811-366f-4256-9277-a59d9222ede4, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:19,071 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 8e3ef811-366f-4256-9277-a59d9222ede4, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:19,074 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 8e3ef811-366f-4256-9277-a59d9222ede4, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:20,820 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:20,821 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:20,821 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 8d601826-4cac-415b-a3ad-9ceda0d9d709, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:20,822 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 8d601826-4cac-415b-a3ad-9ceda0d9d709, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:20,824 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 8d601826-4cac-415b-a3ad-9ceda0d9d709, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:21,493 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:21,494 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:21,495 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 2329bc4c-9b14-4e15-bacd-ac68b2ea740c, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:21,496 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 2329bc4c-9b14-4e15-bacd-ac68b2ea740c, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:21,498 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 2329bc4c-9b14-4e15-bacd-ac68b2ea740c, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:22,307 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:22,308 - INFO - __tests__.alter_compression.1142858  - 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 14:06:22,308 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:22,309 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, f448b7c3-1429-4b21-bd54-7a54a971340e, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:22,310 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, f448b7c3-1429-4b21-bd54-7a54a971340e, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:22,312 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, f448b7c3-1429-4b21-bd54-7a54a971340e, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:23,635 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:23,636 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:23,637 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, aa3933d8-cdd4-45c8-878c-82f1e2dbbbb1, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:23,638 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, aa3933d8-cdd4-45c8-878c-82f1e2dbbbb1, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:23,646 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, aa3933d8-cdd4-45c8-878c-82f1e2dbbbb1, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:24,178 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:24,179 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:24,179 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 87fccb7a-3e29-47b4-a9a3-909a2f059c7d, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:24,180 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 87fccb7a-3e29-47b4-a9a3-909a2f059c7d, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:24,181 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 87fccb7a-3e29-47b4-a9a3-909a2f059c7d, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:25,029 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:25,029 - INFO - __tests__.alter_compression.1142858  - 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 14:06:25,030 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:25,031 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 5967cb50-1d48-4473-bc1d-c7bceef4dbfb, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:25,032 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 5967cb50-1d48-4473-bc1d-c7bceef4dbfb, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:25,033 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 5967cb50-1d48-4473-bc1d-c7bceef4dbfb, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:26,222 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:26,223 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:26,224 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 17d54ff0-9663-4837-9031-95f356b6f09b, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:26,225 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 17d54ff0-9663-4837-9031-95f356b6f09b, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:26,234 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 17d54ff0-9663-4837-9031-95f356b6f09b, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:26,600 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:26,601 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:26,601 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 7c7f304b-6abc-444f-a54a-54df89e7b07e, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:26,602 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 7c7f304b-6abc-444f-a54a-54df89e7b07e, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:26,605 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 7c7f304b-6abc-444f-a54a-54df89e7b07e, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:27,364 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:27,365 - INFO - __tests__.alter_compression.1142858  - 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 14:06:27,365 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:27,366 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, c5b63db2-b585-4d0e-93b8-6f921b0f317d, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:27,367 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, c5b63db2-b585-4d0e-93b8-6f921b0f317d, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:27,368 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, c5b63db2-b585-4d0e-93b8-6f921b0f317d, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:28,370 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:28,371 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:28,372 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, a5ad3c81-2d8a-4409-9984-3baa63ad27b4, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:28,373 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, a5ad3c81-2d8a-4409-9984-3baa63ad27b4, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:28,374 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, a5ad3c81-2d8a-4409-9984-3baa63ad27b4, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:28,591 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:28,592 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:28,592 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 628c8f0a-6342-43ea-be96-935967060bf0, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:28,593 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 628c8f0a-6342-43ea-be96-935967060bf0, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:28,594 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 628c8f0a-6342-43ea-be96-935967060bf0, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:29,056 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:29,056 - INFO - __tests__.alter_compression.1142858  - 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 14:06:29,057 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:29,058 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 21764398-ef4f-4e09-92a9-c1c4fc3b1485, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:29,059 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 21764398-ef4f-4e09-92a9-c1c4fc3b1485, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:29,060 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 21764398-ef4f-4e09-92a9-c1c4fc3b1485, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:30,575 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:30,576 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:30,577 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, d1989b38-fe81-435f-8516-39fbda28eb0c, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:30,577 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, d1989b38-fe81-435f-8516-39fbda28eb0c, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:30,580 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, d1989b38-fe81-435f-8516-39fbda28eb0c, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:31,220 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:31,221 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:31,221 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 5b013ef1-c018-47dc-8fb4-48118ac39ee5, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:31,227 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 5b013ef1-c018-47dc-8fb4-48118ac39ee5, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:31,231 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 5b013ef1-c018-47dc-8fb4-48118ac39ee5, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:32,832 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:32,833 - INFO - __tests__.alter_compression.1142858  - 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 14:06:32,833 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:32,834 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, c3a90a07-d56b-4e0d-a993-f6583bc9cacb, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:32,835 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, c3a90a07-d56b-4e0d-a993-f6583bc9cacb, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:32,837 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, c3a90a07-d56b-4e0d-a993-f6583bc9cacb, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:34,996 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:34,997 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:35,012 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, ccbb1bb1-8fa3-4f91-aa0f-ccbf1bfe884b, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:35,013 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, ccbb1bb1-8fa3-4f91-aa0f-ccbf1bfe884b, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:35,035 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, ccbb1bb1-8fa3-4f91-aa0f-ccbf1bfe884b, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:35,630 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:35,631 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:35,631 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 9bcd7217-8e79-40fe-8568-a86c7021e8ea, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:35,632 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 9bcd7217-8e79-40fe-8568-a86c7021e8ea, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:35,634 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 9bcd7217-8e79-40fe-8568-a86c7021e8ea, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:37,046 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:37,047 - INFO - __tests__.alter_compression.1142858  - 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 14:06:37,047 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:37,048 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, daddf919-f069-4019-a8e3-99061e078dad, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:37,049 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, daddf919-f069-4019-a8e3-99061e078dad, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:37,050 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, daddf919-f069-4019-a8e3-99061e078dad, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:41,311 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:41,312 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:41,313 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, c4f3e659-d99d-4139-bda4-d9d77778e1c6, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:41,314 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, c4f3e659-d99d-4139-bda4-d9d77778e1c6, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:41,333 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, c4f3e659-d99d-4139-bda4-d9d77778e1c6, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:42,576 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:42,577 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:42,578 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 46bbc87f-e04f-44a4-a315-057bcb4989ea, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:42,579 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 46bbc87f-e04f-44a4-a315-057bcb4989ea, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:42,582 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 46bbc87f-e04f-44a4-a315-057bcb4989ea, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:46,096 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:46,097 - INFO - __tests__.alter_compression.1142858  - 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 14:06:46,097 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:46,098 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, d09709c5-9d48-4f83-9b7b-e00c55e07b81, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:46,099 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, d09709c5-9d48-4f83-9b7b-e00c55e07b81, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:46,152 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, d09709c5-9d48-4f83-9b7b-e00c55e07b81, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:52,324 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:52,325 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:52,326 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 443db4e3-c8c6-4e76-93c0-4a3e2e9ebb44, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:52,327 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 443db4e3-c8c6-4e76-93c0-4a3e2e9ebb44, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:52,328 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 443db4e3-c8c6-4e76-93c0-4a3e2e9ebb44, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:53,200 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:53,201 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:53,202 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 9e72985a-02ed-4d22-8f5c-110d324e8e9f, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:53,203 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 9e72985a-02ed-4d22-8f5c-110d324e8e9f, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:53,207 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 9e72985a-02ed-4d22-8f5c-110d324e8e9f, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:55,158 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:55,159 - INFO - __tests__.alter_compression.1142858  - 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 14:06:55,160 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:55,161 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 841b9348-021f-4873-8e3a-39ec26764c3c, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:55,161 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 841b9348-021f-4873-8e3a-39ec26764c3c, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:55,177 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 841b9348-021f-4873-8e3a-39ec26764c3c, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:58,232 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:58,233 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:06:58,234 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, bd106b88-1283-46ce-b816-38aeb26d235a, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:06:58,235 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, bd106b88-1283-46ce-b816-38aeb26d235a, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:06:58,242 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, bd106b88-1283-46ce-b816-38aeb26d235a, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:00,424 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:07:00,425 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:07:00,425 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, b4560509-d7f4-41d6-9650-913c7ac13b81, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:07:00,426 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, b4560509-d7f4-41d6-9650-913c7ac13b81, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:07:00,429 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, b4560509-d7f4-41d6-9650-913c7ac13b81, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:01,099 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:07:01,100 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:07:01,101 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 321fd367-ac36-4139-bd81-ba68f40fc6fc, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:07:01,102 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 321fd367-ac36-4139-bd81-ba68f40fc6fc, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:07:01,105 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 321fd367-ac36-4139-bd81-ba68f40fc6fc, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:13,417 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:07:23,643 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:07:23,644 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 0bdd6874-26e6-46c6-ac08-e9dbc24324d6, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:07:23,645 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 0bdd6874-26e6-46c6-ac08-e9dbc24324d6, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:07:23,646 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 0bdd6874-26e6-46c6-ac08-e9dbc24324d6, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:27,175 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:07:27,197 - INFO - root.1142858  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8050688)
2025-11-21 14:07:27,198 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:07:27,198 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, c58e1d2d-cfa9-401f-b68e-1eb04abcdee8, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:07:27,200 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, c58e1d2d-cfa9-401f-b68e-1eb04abcdee8, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:07:27,201 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, c58e1d2d-cfa9-401f-b68e-1eb04abcdee8, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:33,759 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:07:43,790 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:07:43,791 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 5d554dea-f26f-4a0f-9db9-63db108daad5, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:07:43,792 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 5d554dea-f26f-4a0f-9db9-63db108daad5, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:07:43,794 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 5d554dea-f26f-4a0f-9db9-63db108daad5, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:46,267 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:07:56,281 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:07:56,282 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 54e72709-62c7-441e-b3f0-7673540520f3, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:07:56,283 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 54e72709-62c7-441e-b3f0-7673540520f3, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:07:56,284 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 54e72709-62c7-441e-b3f0-7673540520f3, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:57,208 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:07:57,213 - INFO - root.1142858  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8009216)
2025-11-21 14:07:57,214 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:07:57,215 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 8b4256d7-7bcf-4b0d-8843-24d10f9452fb, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:07:57,216 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 8b4256d7-7bcf-4b0d-8843-24d10f9452fb, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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 14:07:57,234 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 8b4256d7-7bcf-4b0d-8843-24d10f9452fb, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:58,444 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:07:58,448 - INFO - ya.test.1142858  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_18_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 18])
2025-11-21 14:07:58,449 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:07:58,450 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 90e3b338-735a-4ed4-8013-9addccb12131, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:07:58,466 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 90e3b338-735a-4ed4-8013-9addccb12131, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_18_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 18)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:07:58,468 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 90e3b338-735a-4ed4-8013-9addccb12131, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:00,489 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1142858  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-21 14:08:00,490 - DEBUG - ydb.connection.1142858  - 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 14:08:00,514 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1142858  - context_resolve: Resolving endpoints for database /Root
2025-11-21 14:08:00,515 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ListEndpoints, 24ac9d32-5d45-46fb-a249-bc45a2b132a4, localhost:22973): creating call state
2025-11-21 14:08:00,516 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ListEndpoints, 24ac9d32-5d45-46fb-a249-bc45a2b132a4, localhost:22973): request = { database: "/Root" }
2025-11-21 14:08:00,724 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ListEndpoints, 24ac9d32-5d45-46fb-a249-bc45a2b132a4, localhost:22973): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-acwccf6kvy.auto.internal" port: 22973 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 14:08:00,725 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1142858  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-acwccf6kvy.auto.internal:22973, location 1, ssl: False>]>
2025-11-21 14:08:00,747 - DEBUG - ydb.connection.1142858  - close: Closing channel for endpoint localhost:22973
2025-11-21 14:08:08,073 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:08:08,074 - INFO - __tests__.alter_compression.1142858  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_18_compression created
2025-11-21 14:08:08,074 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:08:08,075 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 460c7b90-78de-4abc-a73a-e26799466211, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:08:08,076 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 460c7b90-78de-4abc-a73a-e26799466211, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_18_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:08,078 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 460c7b90-78de-4abc-a73a-e26799466211, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:10,282 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:08:10,283 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:08:10,284 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 80371f8f-37fa-40b3-8318-7059bcc919be, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:08:10,286 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 80371f8f-37fa-40b3-8318-7059bcc919be, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:10,291 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 80371f8f-37fa-40b3-8318-7059bcc919be, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:20,216 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:08:20,217 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:08:20,218 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 8c5d71f3-ca82-4f86-a7e9-5eef5b104353, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:08:20,230 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 8c5d71f3-ca82-4f86-a7e9-5eef5b104353, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:20,233 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 8c5d71f3-ca82-4f86-a7e9-5eef5b104353, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:22,796 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:08:22,797 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:08:22,798 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 5aab0f69-0942-4489-bb70-d4ccdbfab0d0, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:08:22,803 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 5aab0f69-0942-4489-bb70-d4ccdbfab0d0, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:22,805 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 5aab0f69-0942-4489-bb70-d4ccdbfab0d0, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:27,263 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:08:27,264 - INFO - __tests__.alter_compression.1142858  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318528, 'BlobCount': 128}}
2025-11-21 14:08:27,265 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:08:27,266 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 82c0ae6f-3708-460b-898f-5fa3749e60a5, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:08:27,266 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 82c0ae6f-3708-460b-898f-5fa3749e60a5, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:27,269 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 82c0ae6f-3708-460b-898f-5fa3749e60a5, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:37,467 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:08:37,468 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:08:37,469 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 143c3995-e790-43b1-a357-1c1c91fc95fb, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:08:37,470 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 143c3995-e790-43b1-a357-1c1c91fc95fb, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:37,473 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 143c3995-e790-43b1-a357-1c1c91fc95fb, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:38,166 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:08:38,167 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:08:38,168 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 9b96c9f8-9ccc-4a19-b1e3-d9ac96788244, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:08:38,169 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 9b96c9f8-9ccc-4a19-b1e3-d9ac96788244, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:38,175 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 9b96c9f8-9ccc-4a19-b1e3-d9ac96788244, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:39,083 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:08:39,084 - INFO - __tests__.alter_compression.1142858  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 637920, 'BlobCount': 256}}
2025-11-21 14:08:39,085 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:08:39,086 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, a7c3c557-e3e4-4802-afcf-7b35b60a3308, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:08:39,087 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, a7c3c557-e3e4-4802-afcf-7b35b60a3308, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:39,089 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, a7c3c557-e3e4-4802-afcf-7b35b60a3308, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:47,307 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:08:47,308 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:08:47,309 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 1d8cd4a1-e428-4af0-aff7-6bcc79c399c6, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:08:47,310 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 1d8cd4a1-e428-4af0-aff7-6bcc79c399c6, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:47,312 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 1d8cd4a1-e428-4af0-aff7-6bcc79c399c6, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:47,890 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:08:47,891 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:08:47,892 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, c17ff897-3a71-4b69-8c0c-367b9b5e7b97, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:08:47,893 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, c17ff897-3a71-4b69-8c0c-367b9b5e7b97, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:47,904 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, c17ff897-3a71-4b69-8c0c-367b9b5e7b97, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:48,743 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:08:48,744 - INFO - __tests__.alter_compression.1142858  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 956816, 'BlobCount': 384}}
2025-11-21 14:08:48,744 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:08:48,745 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, d477370b-a99e-483a-a666-3bc2e39671a7, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:08:48,746 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, d477370b-a99e-483a-a666-3bc2e39671a7, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:48,747 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, d477370b-a99e-483a-a666-3bc2e39671a7, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:59,992 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:08:59,992 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:08:59,993 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, fd386cda-2a90-4b40-b98f-35efa75d3ff0, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:08:59,994 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, fd386cda-2a90-4b40-b98f-35efa75d3ff0, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:00,003 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, fd386cda-2a90-4b40-b98f-35efa75d3ff0, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:00,943 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:00,944 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:00,945 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 8d436234-35bf-49ad-9c62-d8f05168ca8a, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:09:00,946 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 8d436234-35bf-49ad-9c62-d8f05168ca8a, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:00,969 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 8d436234-35bf-49ad-9c62-d8f05168ca8a, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:01,860 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:01,861 - INFO - __tests__.alter_compression.1142858  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1276240, 'BlobCount': 512}}
2025-11-21 14:09:01,862 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:01,863 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, d7154a5c-289d-4f2c-a3eb-da6dbf90307e, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:09:01,864 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, d7154a5c-289d-4f2c-a3eb-da6dbf90307e, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:01,865 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, d7154a5c-289d-4f2c-a3eb-da6dbf90307e, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:08,179 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:08,181 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:08,182 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 65545b72-0701-4e69-9371-573f4733e57a, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:09:08,183 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 65545b72-0701-4e69-9371-573f4733e57a, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:08,185 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 65545b72-0701-4e69-9371-573f4733e57a, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:08,855 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:08,857 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:08,857 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 5576b0cf-f2a4-4408-b20e-8603c8d50dad, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:09:08,868 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 5576b0cf-f2a4-4408-b20e-8603c8d50dad, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:08,870 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 5576b0cf-f2a4-4408-b20e-8603c8d50dad, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:09,618 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:09,619 - INFO - __tests__.alter_compression.1142858  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1595136, 'BlobCount': 640}}
2025-11-21 14:09:09,619 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:09,620 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 45c145de-9f01-43bc-9db4-f5bb004ab3d1, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:09:09,621 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 45c145de-9f01-43bc-9db4-f5bb004ab3d1, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:09,641 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 45c145de-9f01-43bc-9db4-f5bb004ab3d1, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:17,512 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:17,513 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:17,514 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 4d02a5b8-0b1b-4dcf-807b-7d9863c1a2b0, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:09:17,515 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 4d02a5b8-0b1b-4dcf-807b-7d9863c1a2b0, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:17,516 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 4d02a5b8-0b1b-4dcf-807b-7d9863c1a2b0, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:18,359 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:18,360 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:18,360 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 810c9e98-2f85-4251-8649-c598ad601f30, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:09:18,361 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 810c9e98-2f85-4251-8649-c598ad601f30, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:18,382 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 810c9e98-2f85-4251-8649-c598ad601f30, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:19,327 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:19,328 - INFO - __tests__.alter_compression.1142858  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1914416, 'BlobCount': 768}}
2025-11-21 14:09:19,329 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:19,330 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, c9d7b586-2288-4568-af32-69c842afc14a, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:09:19,335 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, c9d7b586-2288-4568-af32-69c842afc14a, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:19,337 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, c9d7b586-2288-4568-af32-69c842afc14a, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:26,007 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:26,008 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:26,009 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 889e0f82-c4e7-4aac-86b5-1d3fb3c854d1, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:09:26,010 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 889e0f82-c4e7-4aac-86b5-1d3fb3c854d1, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:26,013 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 889e0f82-c4e7-4aac-86b5-1d3fb3c854d1, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:26,835 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:26,836 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:26,837 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 64ba20b0-22d1-4f67-92af-4c89540d71a5, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:09:26,838 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 64ba20b0-22d1-4f67-92af-4c89540d71a5, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:26,840 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 64ba20b0-22d1-4f67-92af-4c89540d71a5, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:28,042 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:28,042 - INFO - __tests__.alter_compression.1142858  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2233456, 'BlobCount': 896}}
2025-11-21 14:09:28,043 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:28,044 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, e0f97d11-8d5b-4db6-acd3-159435a721c5, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:09:28,045 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, e0f97d11-8d5b-4db6-acd3-159435a721c5, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:28,048 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, e0f97d11-8d5b-4db6-acd3-159435a721c5, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:37,477 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:37,478 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:37,478 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 50132040-84f7-4022-b4c6-0813c34b3835, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:09:37,480 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 50132040-84f7-4022-b4c6-0813c34b3835, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:37,481 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 50132040-84f7-4022-b4c6-0813c34b3835, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:38,292 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:38,293 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:38,295 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 8c50a90d-9c90-4c70-9366-f39c78290bc2, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:09:38,296 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 8c50a90d-9c90-4c70-9366-f39c78290bc2, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:38,298 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 8c50a90d-9c90-4c70-9366-f39c78290bc2, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:40,065 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:40,066 - INFO - __tests__.alter_compression.1142858  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2552960, 'BlobCount': 1024}}
2025-11-21 14:09:40,066 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:40,067 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 09a5c741-a3dc-4fb0-b926-fc3f028e5988, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:09:40,068 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 09a5c741-a3dc-4fb0-b926-fc3f028e5988, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:40,069 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 09a5c741-a3dc-4fb0-b926-fc3f028e5988, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:43,831 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1142858  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-21 14:09:43,832 - DEBUG - ydb.connection.1142858  - 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 14:09:43,909 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1142858  - context_resolve: Resolving endpoints for database /Root
2025-11-21 14:09:43,910 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ListEndpoints, eae2927b-f3f0-4d3d-a73b-e4f7a23db629, localhost:22973): creating call state
2025-11-21 14:09:43,910 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ListEndpoints, eae2927b-f3f0-4d3d-a73b-e4f7a23db629, localhost:22973): request = { database: "/Root" }
2025-11-21 14:09:43,918 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ListEndpoints, eae2927b-f3f0-4d3d-a73b-e4f7a23db629, localhost:22973): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-acwccf6kvy.auto.internal" port: 22973 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 14:09:43,919 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1142858  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-acwccf6kvy.auto.internal:22973, location 1, ssl: False>]>
2025-11-21 14:09:43,920 - DEBUG - ydb.connection.1142858  - close: Closing channel for endpoint localhost:22973
2025-11-21 14:09:47,422 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:47,422 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:47,423 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, adc6b91c-3de5-4643-ae80-0bbf6d72a125, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:09:47,424 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, adc6b91c-3de5-4643-ae80-0bbf6d72a125, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:47,426 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, adc6b91c-3de5-4643-ae80-0bbf6d72a125, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:48,128 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:48,129 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:48,130 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, b39506c2-c678-42da-b6d9-8e6ed31dab49, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:09:48,130 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, b39506c2-c678-42da-b6d9-8e6ed31dab49, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:48,135 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, b39506c2-c678-42da-b6d9-8e6ed31dab49, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:50,328 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:50,361 - INFO - __tests__.alter_compression.1142858  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2871840, 'BlobCount': 1152}}
2025-11-21 14:09:50,361 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:09:50,362 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 192bba57-f2fb-4327-b1a1-5c93843b9cee, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:09:50,363 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 192bba57-f2fb-4327-b1a1-5c93843b9cee, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:50,364 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 192bba57-f2fb-4327-b1a1-5c93843b9cee, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:10:00,337 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:10:00,338 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:10:00,352 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 1712ba0f-b00b-4ba6-9686-33da3c858828, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:10:00,353 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 1712ba0f-b00b-4ba6-9686-33da3c858828, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:10:00,354 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 1712ba0f-b00b-4ba6-9686-33da3c858828, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:10:01,250 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:10:01,251 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:10:01,252 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 113300b2-74b1-42d2-a770-ebb29f553ec3, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:10:01,253 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 113300b2-74b1-42d2-a770-ebb29f553ec3, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:10:01,264 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 113300b2-74b1-42d2-a770-ebb29f553ec3, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:10:02,892 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:10:02,893 - INFO - __tests__.alter_compression.1142858  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3191408, 'BlobCount': 1280}}
2025-11-21 14:10:02,894 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:10:02,895 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 1302d0c0-06d2-4d35-93cc-3123a101ad14, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:10:02,896 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 1302d0c0-06d2-4d35-93cc-3123a101ad14, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_18_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:10:02,898 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 1302d0c0-06d2-4d35-93cc-3123a101ad14, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:10:07,236 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:10:07,237 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:10:07,237 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, fab31284-f43d-44f3-82bd-04da374a27f2, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:10:07,238 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, fab31284-f43d-44f3-82bd-04da374a27f2, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:10:07,246 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, fab31284-f43d-44f3-82bd-04da374a27f2, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:10:08,378 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:10:08,379 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:10:08,379 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, e35be2d0-e9c7-49b3-8ba2-9fce989ce3ef, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:10:08,380 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, e35be2d0-e9c7-49b3-8ba2-9fce989ce3ef, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:10:08,386 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, e35be2d0-e9c7-49b3-8ba2-9fce989ce3ef, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:10:09,323 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:10:09,324 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:10:09,325 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 84dc8923-8bd4-44cd-9151-90cdda4fd9d7, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:10:09,326 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 84dc8923-8bd4-44cd-9151-90cdda4fd9d7, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_18_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:10:09,329 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 84dc8923-8bd4-44cd-9151-90cdda4fd9d7, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:10:18,988 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:10:29,039 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:10:29,040 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 6e59bd05-18b4-4745-a942-6da1b6688a55, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:10:29,041 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 6e59bd05-18b4-4745-a942-6da1b6688a55, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_18_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:10:29,042 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 6e59bd05-18b4-4745-a942-6da1b6688a55, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:10:31,372 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:10:41,387 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:10:41,388 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 86f4c797-165d-4b55-b1c3-65e44baf2ab3, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:10:41,388 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 86f4c797-165d-4b55-b1c3-65e44baf2ab3, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_18_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:10:41,390 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 86f4c797-165d-4b55-b1c3-65e44baf2ab3, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:10:43,062 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:10:53,067 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:10:53,072 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, cbce9510-9a26-4fd4-93b3-72feceae1842, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:10:53,073 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, cbce9510-9a26-4fd4-93b3-72feceae1842, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_18_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:10:53,074 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, cbce9510-9a26-4fd4-93b3-72feceae1842, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:10:55,407 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:10:55,411 - INFO - root.1142858  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_18_compression`, volumes `value` (8000000, 1497984)
2025-11-21 14:10:55,417 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:10:55,418 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 229732a2-6e22-46ec-97e6-3748e4edec2d, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:10:55,419 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 229732a2-6e22-46ec-97e6-3748e4edec2d, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:10:55,421 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 229732a2-6e22-46ec-97e6-3748e4edec2d, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:10:56,240 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:10:56,241 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:10:56,241 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, 8b5eea26-3122-43b8-acd7-b60266445d85, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:10:56,242 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, 8b5eea26-3122-43b8-acd7-b60266445d85, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_18_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:10:56,244 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, 8b5eea26-3122-43b8-acd7-b60266445d85, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:10:58,629 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:11:08,633 - DEBUG - ydb.query.pool.1142858  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:11:08,634 - DEBUG - ydb.connection.1142858  - _prepare_call: RpcState(ExecuteQuery, c5355665-ce8a-4384-a267-005eb595c7df, ghrun-acwccf6kvy.auto.internal:22973): creating call state
2025-11-21 14:11:08,635 - DEBUG - ydb.connection.1142858  - _log_request: RpcState(ExecuteQuery, c5355665-ce8a-4384-a267-005eb595c7df, ghrun-acwccf6kvy.auto.internal:22973): request = { session_id: "ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_18_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:11:08,637 - DEBUG - ydb.connection.1142858  - _log_response: RpcState(ExecuteQuery, c5355665-ce8a-4384-a267-005eb595c7df, ghrun-acwccf6kvy.auto.internal:22973): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:11:11,533 - DEBUG - ydb.query.pool.1142858  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTU4YjFlNGEtN2QxODg2MmEtOWZjOTJkNmQtZDVkM2RiOGY=
2025-11-21 14:11:11,538 - INFO - root.1142858  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_18_compression`, volumes `value` (8000000, 1497984)
2025-11-21 14:11:11,538 - INFO - root.1142858  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_18_compression` 8050688 / 1497984: 5.374348457660429
2025-11-21 14:11:11,568 - INFO - ya.test.1142858  - pytest_runtest_teardown: Test teardown
