2025-12-23 17:49:25,230 - INFO - ya.test.2335780  - pytest_runtest_setup: ####################################################################################################
2025-12-23 17:49:25,230 - INFO - ya.test.2335780  - pytest_runtest_setup: test_all_supported_compression[zstd_6_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 6]
2025-12-23 17:49:25,231 - INFO - ya.test.2335780  - pytest_runtest_setup: ####################################################################################################
2025-12-23 17:49:25,231 - INFO - ya.test.2335780  - pytest_runtest_setup: Test setup
2025-12-23 17:49:25,233 - DEBUG - ya.test.2335780  - _get_command_output_file: Command out will be placed to ydbd.out
2025-12-23 17:49:25,234 - DEBUG - ya.test.2335780  - _get_command_output_file: Command err will be placed to ydbd.err
2025-12-23 17:49:25,234 - DEBUG - ya.test.2335780  - execute: Executing '['/home/runner/.ya/build/build_root/w2fb/001dae/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-23 17:49:25,236 - DEBUG - ya.test.2335780  - execute: Command pid: 2336460
2025-12-23 17:49:25,984 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336460) rc: 0
2025-12-23 17:49:25,985 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336460) elapsed time (sec): 0.743659496307373
2025-12-23 17:49:25,985 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336460) idrss: 0
2025-12-23 17:49:25,985 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336460) inblock: 8
2025-12-23 17:49:25,986 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336460) isrss: 0
2025-12-23 17:49:25,986 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336460) ixrss: 0
2025-12-23 17:49:25,986 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336460) majflt: 1
2025-12-23 17:49:25,987 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336460) maxrss: 505176
2025-12-23 17:49:25,987 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336460) minflt: 45868
2025-12-23 17:49:25,987 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336460) msgrcv: 0
2025-12-23 17:49:25,987 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336460) msgsnd: 0
2025-12-23 17:49:25,988 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336460) nivcsw: 56
2025-12-23 17:49:25,988 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336460) nsignals: 0
2025-12-23 17:49:25,988 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336460) nswap: 0
2025-12-23 17:49:25,989 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336460) nvcsw: 14
2025-12-23 17:49:25,989 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336460) oublock: 8
2025-12-23 17:49:25,989 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336460) stime: 0.193102
2025-12-23 17:49:25,989 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336460) utime: 0.472018
2025-12-23 17:49:25,990 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336460) wtime: 0.746
2025-12-23 17:49:25,990 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336460) output:
Git info:
    Commit: 36060cc90e9313d79d78f7e01e8251dfc0b9a307
    Branch: 
    Author: Pavel Velikhov <pavel.velikhov@gmail.com>
    Summary: Merge 11f4dd79bc2e09e94b7f6457af93c1ee041776e2 into 7a46c6293674d1de550a9922546b7e0022176cfa
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-yh5r7pxf7y    Host information: 
        Linux ghrun-yh5r7pxf7y 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

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

2025-12-23 17:49:25,990 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336460) errors:

2025-12-23 17:49:25,991 - INFO - __tests__.base.2335780  - _setup_ydb: Git info:
    Commit: 36060cc90e9313d79d78f7e01e8251dfc0b9a307
    Branch: 
    Author: Pavel Velikhov <pavel.velikhov@gmail.com>
    Summary: Merge 11f4dd79bc2e09e94b7f6457af93c1ee041776e2 into 7a46c6293674d1de550a9922546b7e0022176cfa
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-yh5r7pxf7y    Host information: 
        Linux ghrun-yh5r7pxf7y 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

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

2025-12-23 17:49:26,101 - DEBUG - ya.test.2335780  - get_binary: Binary was found by /home/runner/.ya/build/build_root/w2fb/001dae/ydb/apps/ydbd/ydbd
2025-12-23 17:49:26,103 - DEBUG - library.python.filelock.2335780  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/20628
2025-12-23 17:49:26,105 - DEBUG - ydb.tests.library.harness.kikimr_runner.2335780  - start: Working directory: /home/runner/.ya/build/build_root/w2fb/001dae/r3tmp/kikimr_cluster_mq6o4hzq
2025-12-23 17:49:26,158 - DEBUG - ya.test.2335780  - get_binary: Binary was found by /home/runner/.ya/build/build_root/w2fb/001dae/ydb/apps/ydbd/ydbd
2025-12-23 17:49:26,159 - DEBUG - library.python.filelock.2335780  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/63283
2025-12-23 17:49:26,160 - DEBUG - library.python.filelock.2335780  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/64405
2025-12-23 17:49:26,160 - DEBUG - library.python.filelock.2335780  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/22520
2025-12-23 17:49:26,161 - DEBUG - library.python.filelock.2335780  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/6650
2025-12-23 17:49:26,162 - INFO - ydb.tests.library.harness.kikimr_runner.2335780  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/w2fb/001dae/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_6_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.6/cluster/kikimr_configs"
2025-12-23 17:49:26,162 - INFO - ydb.tests.library.harness.kikimr_runner.2335780  - __make_run_command: Final command: /home/runner/.ya/build/build_root/w2fb/001dae/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/w2fb/001dae/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_6_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.6/cluster/node_1/logfile_cf9yh7l0.log --grpc-port=63283 --mon-port=64405 --ic-port=20628
2025-12-23 17:49:26,163 - DEBUG - ydb.tests.library.harness.kikimr_runner.2335780  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:63283/1, disk_size 68719476736
2025-12-23 17:49:26,163 - INFO - ydb.tests.library.harness.kikimr_runner.2335780  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/w2fb/001dae/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_6_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.6/cluster/kikimr_configs"
2025-12-23 17:49:26,164 - INFO - ydb.tests.library.harness.kikimr_runner.2335780  - __make_run_command: Final command: /home/runner/.ya/build/build_root/w2fb/001dae/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/w2fb/001dae/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_6_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.6/cluster/node_1/logfile_cf9yh7l0.log --grpc-port=63283 --mon-port=64405 --ic-port=20628
2025-12-23 17:49:26,165 - DEBUG - ya.test.2335780  - execute: Executing '('/home/runner/.ya/build/build_root/w2fb/001dae/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/w2fb/001dae/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_6_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.6/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/w2fb/001dae/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_6_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.6/cluster/node_1/logfile_cf9yh7l0.log', '--grpc-port=63283', '--mon-port=64405', '--ic-port=20628')' in '/home/runner/.ya/build/build_root/w2fb/001dae/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_6_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.6/cluster/node_1' (no wait)
2025-12-23 17:49:26,168 - DEBUG - ya.test.2335780  - execute: Command pid: 2336855
2025-12-23 17:49:26,169 - INFO - ydb.tests.library.harness.kikimr_runner.2335780  - start: Started node localhost:63283/1
2025-12-23 17:49:26,170 - DEBUG - ya.test.2335780  - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-12-23 17:49:26,171 - DEBUG - ya.test.2335780  - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-12-23 17:49:26,171 - DEBUG - ya.test.2335780  - execute: Executing '['/home/runner/.ya/build/build_root/w2fb/001dae/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-23 17:49:26,173 - DEBUG - ya.test.2335780  - execute: Command pid: 2336861
2025-12-23 17:49:26,986 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336861) rc: 0
2025-12-23 17:49:26,986 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336861) elapsed time (sec): 0.806464672088623
2025-12-23 17:49:26,987 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336861) idrss: 0
2025-12-23 17:49:26,987 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336861) inblock: 0
2025-12-23 17:49:26,987 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336861) isrss: 0
2025-12-23 17:49:26,987 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336861) ixrss: 0
2025-12-23 17:49:26,988 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336861) majflt: 0
2025-12-23 17:49:26,988 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336861) maxrss: 514084
2025-12-23 17:49:26,989 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336861) minflt: 45806
2025-12-23 17:49:26,989 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336861) msgrcv: 0
2025-12-23 17:49:26,989 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336861) msgsnd: 0
2025-12-23 17:49:26,989 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336861) nivcsw: 102
2025-12-23 17:49:26,990 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336861) nsignals: 0
2025-12-23 17:49:26,990 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336861) nswap: 0
2025-12-23 17:49:26,991 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336861) nvcsw: 14
2025-12-23 17:49:26,991 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336861) oublock: 8
2025-12-23 17:49:26,992 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336861) stime: 0.190023
2025-12-23 17:49:26,992 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336861) utime: 0.533732
2025-12-23 17:49:26,992 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336861) wtime: 0.808
2025-12-23 17:49:26,993 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336861) output:
Git info:
    Commit: 36060cc90e9313d79d78f7e01e8251dfc0b9a307
    Branch: 
    Author: Pavel Velikhov <pavel.velikhov@gmail.com>
    Summary: Merge 11f4dd79bc2e09e94b7f6457af93c1ee041776e2 into 7a46c6293674d1de550a9922546b7e0022176cfa
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-yh5r7pxf7y    Host information: 
        Linux ghrun-yh5r7pxf7y 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

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

2025-12-23 17:49:26,993 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2336861) errors:

2025-12-23 17:49:26,994 - INFO - ydb.tests.library.harness.kikimr_runner.2335780  - start: Node 1 version:
Git info:
    Commit: 36060cc90e9313d79d78f7e01e8251dfc0b9a307
    Branch: 
    Author: Pavel Velikhov <pavel.velikhov@gmail.com>
    Summary: Merge 11f4dd79bc2e09e94b7f6457af93c1ee041776e2 into 7a46c6293674d1de550a9922546b7e0022176cfa
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-yh5r7pxf7y    Host information: 
        Linux ghrun-yh5r7pxf7y 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64
2025-12-23 17:49:32,425 - DEBUG - ya.test.2335780  - get_binary: Binary was found by /home/runner/.ya/build/build_root/w2fb/001dae/ydb/apps/ydbd/ydbd
2025-12-23 17:49:32,425 - DEBUG - ydb.tests.library.harness.kikimr_runner.2335780  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/w2fb/001dae/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:63283', '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: 20628\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-12-23 17:49:32,427 - DEBUG - ya.test.2335780  - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-12-23 17:49:32,428 - DEBUG - ya.test.2335780  - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-12-23 17:49:32,434 - DEBUG - ya.test.2335780  - execute: Executing '['/home/runner/.ya/build/build_root/w2fb/001dae/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:63283', '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: 20628\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-12-23 17:49:32,448 - DEBUG - ya.test.2335780  - execute: Command pid: 2339147
2025-12-23 17:49:33,567 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339147) rc: 0
2025-12-23 17:49:33,568 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339147) elapsed time (sec): 1.1175603866577148
2025-12-23 17:49:33,568 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339147) idrss: 0
2025-12-23 17:49:33,568 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339147) inblock: 0
2025-12-23 17:49:33,569 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339147) isrss: 0
2025-12-23 17:49:33,569 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339147) ixrss: 0
2025-12-23 17:49:33,569 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339147) majflt: 0
2025-12-23 17:49:33,570 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339147) maxrss: 600660
2025-12-23 17:49:33,570 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339147) minflt: 52188
2025-12-23 17:49:33,570 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339147) msgrcv: 0
2025-12-23 17:49:33,570 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339147) msgsnd: 0
2025-12-23 17:49:33,571 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339147) nivcsw: 175
2025-12-23 17:49:33,571 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339147) nsignals: 0
2025-12-23 17:49:33,571 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339147) nswap: 0
2025-12-23 17:49:33,572 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339147) nvcsw: 860
2025-12-23 17:49:33,572 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339147) oublock: 8
2025-12-23 17:49:33,572 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339147) stime: 0.25501
2025-12-23 17:49:33,573 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339147) utime: 0.635057
2025-12-23 17:49:33,573 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339147) wtime: 1.132
2025-12-23 17:49:33,573 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339147) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-12-23 17:49:33,573 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339147) errors:

2025-12-23 17:49:33,575 - DEBUG - ya.test.2335780  - get_binary: Binary was found by /home/runner/.ya/build/build_root/w2fb/001dae/ydb/apps/ydbd/ydbd
2025-12-23 17:49:33,576 - DEBUG - ydb.tests.library.harness.kikimr_runner.2335780  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/w2fb/001dae/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:63283', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']
2025-12-23 17:49:33,577 - DEBUG - ya.test.2335780  - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-12-23 17:49:33,578 - DEBUG - ya.test.2335780  - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-12-23 17:49:33,578 - DEBUG - ya.test.2335780  - execute: Executing '['/home/runner/.ya/build/build_root/w2fb/001dae/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:63283', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']' in 'None' (waiting)
2025-12-23 17:49:33,580 - DEBUG - ya.test.2335780  - execute: Command pid: 2339384
2025-12-23 17:49:34,678 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339384) rc: 0
2025-12-23 17:49:34,679 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339384) elapsed time (sec): 1.090916633605957
2025-12-23 17:49:34,679 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339384) idrss: 0
2025-12-23 17:49:34,680 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339384) inblock: 0
2025-12-23 17:49:34,680 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339384) isrss: 0
2025-12-23 17:49:34,680 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339384) ixrss: 0
2025-12-23 17:49:34,681 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339384) majflt: 0
2025-12-23 17:49:34,681 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339384) maxrss: 600660
2025-12-23 17:49:34,681 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339384) minflt: 52261
2025-12-23 17:49:34,681 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339384) msgrcv: 0
2025-12-23 17:49:34,682 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339384) msgsnd: 0
2025-12-23 17:49:34,682 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339384) nivcsw: 184
2025-12-23 17:49:34,682 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339384) nsignals: 0
2025-12-23 17:49:34,682 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339384) nswap: 0
2025-12-23 17:49:34,683 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339384) nvcsw: 597
2025-12-23 17:49:34,683 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339384) oublock: 8
2025-12-23 17:49:34,683 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339384) stime: 0.25443099999999996
2025-12-23 17:49:34,684 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339384) utime: 0.600089
2025-12-23 17:49:34,684 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339384) wtime: 1.093
2025-12-23 17:49:34,684 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339384) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-12-23 17:49:34,685 - DEBUG - ya.test.2335780  - _save_outputs: Command (pid 2339384) errors:

2025-12-23 17:49:34,685 - INFO - ydb.tests.library.harness.kikimr_runner.2335780  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-12-23 17:49:34,856 - INFO - ydb.tests.library.harness.kikimr_runner.2335780  - __run: Cluster started and initialized
2025-12-23 17:49:34,902 - DEBUG - ydb.connection.2335780  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 17:49:34,906 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335780  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-23 17:49:34,906 - DEBUG - ydb.connection.2335780  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 17:49:34,951 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335780  - context_resolve: Resolving endpoints for database /Root
2025-12-23 17:49:34,952 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ListEndpoints, b2a5f259-0232-431a-b21e-8e0b5dbee51f, localhost:63283): creating call state
2025-12-23 17:49:34,953 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ListEndpoints, b2a5f259-0232-431a-b21e-8e0b5dbee51f, localhost:63283): request = { database: "/Root" }
2025-12-23 17:49:34,962 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ListEndpoints, b2a5f259-0232-431a-b21e-8e0b5dbee51f, localhost:63283): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-yh5r7pxf7y.auto.internal" port: 63283 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-12-23 17:49:34,963 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335780  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-yh5r7pxf7y.auto.internal:63283, location 1, ssl: False>]>
2025-12-23 17:49:34,964 - DEBUG - ydb.connection.2335780  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 17:49:34,985 - DEBUG - ydb.connection.2335780  - close: Closing channel for endpoint localhost:63283
2025-12-23 17:49:34,989 - DEBUG - ydb.query.pool.2335780  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-23 17:49:34,990 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(CreateSession, eef72106-756e-458f-b4df-3b58809b2b41, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:49:34,991 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(CreateSession, eef72106-756e-458f-b4df-3b58809b2b41, ghrun-yh5r7pxf7y.auto.internal:63283): request = {  }
2025-12-23 17:49:35,002 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(CreateSession, eef72106-756e-458f-b4df-3b58809b2b41, ghrun-yh5r7pxf7y.auto.internal:63283): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" node_id: 1 }
2025-12-23 17:49:35,003 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(AttachSession, 753c9eee-9079-4923-a777-0b8bc11a20af, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:49:35,003 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(AttachSession, 753c9eee-9079-4923-a777-0b8bc11a20af, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" }
2025-12-23 17:49:35,011 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(AttachSession, 753c9eee-9079-4923-a777-0b8bc11a20af, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:35,032 - DEBUG - ydb.query.pool.2335780  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:35,033 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, bc13249c-a25a-4774-a993-e7e464d6ed90, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:49:35,035 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, bc13249c-a25a-4774-a993-e7e464d6ed90, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/off_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"off\")\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:35,039 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, bc13249c-a25a-4774-a993-e7e464d6ed90, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:38,560 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:38,561 - INFO - __tests__.alter_compression.2335780  - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-12-23 17:49:38,561 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:38,562 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 4b993218-dbe1-4cad-b4bc-5932fd2238af, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:49:38,563 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 4b993218-dbe1-4cad-b4bc-5932fd2238af, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/off_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:38,565 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 4b993218-dbe1-4cad-b4bc-5932fd2238af, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:40,138 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:40,139 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:40,140 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 9864815d-616f-4ce9-a309-2743a187b9f2, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:49:40,141 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 9864815d-616f-4ce9-a309-2743a187b9f2, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 0;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:40,142 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 9864815d-616f-4ce9-a309-2743a187b9f2, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:41,566 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:41,567 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:41,567 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 1b3f4b6a-9fa7-4a73-a8ba-efaa08c2632f, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:49:41,568 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 1b3f4b6a-9fa7-4a73-a8ba-efaa08c2632f, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:41,570 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 1b3f4b6a-9fa7-4a73-a8ba-efaa08c2632f, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:42,549 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:42,550 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:42,550 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 8360cf1e-a5ee-4d47-8910-7fbc85f9895f, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:49:42,551 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 8360cf1e-a5ee-4d47-8910-7fbc85f9895f, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:42,553 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 8360cf1e-a5ee-4d47-8910-7fbc85f9895f, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:44,253 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:44,254 - INFO - __tests__.alter_compression.2335780  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 1618432, 'BlobCount': 128}}
2025-12-23 17:49:44,254 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:44,255 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 363bf1d1-393b-45c6-a3fb-cf844d031121, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:49:44,256 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 363bf1d1-393b-45c6-a3fb-cf844d031121, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 100000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:44,259 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 363bf1d1-393b-45c6-a3fb-cf844d031121, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:45,416 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:45,417 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:45,418 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, bef2ff56-7082-45d8-81a0-a60e6b6f5231, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:49:45,419 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, bef2ff56-7082-45d8-81a0-a60e6b6f5231, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:45,422 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, bef2ff56-7082-45d8-81a0-a60e6b6f5231, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:45,930 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:45,931 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:45,932 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, b0844c8f-303d-4e9a-a4b0-b698d9da976a, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:49:45,932 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, b0844c8f-303d-4e9a-a4b0-b698d9da976a, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:45,934 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, b0844c8f-303d-4e9a-a4b0-b698d9da976a, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:46,696 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:46,697 - INFO - __tests__.alter_compression.2335780  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 3236864, 'BlobCount': 256}}
2025-12-23 17:49:46,698 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:46,698 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 02bbd6ce-379c-4d62-87a8-183f326411bc, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:49:46,699 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 02bbd6ce-379c-4d62-87a8-183f326411bc, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 200000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:46,701 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 02bbd6ce-379c-4d62-87a8-183f326411bc, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:47,826 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:47,827 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:47,827 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, e2683d11-d006-43fb-a90f-80122a9287f0, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:49:47,828 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, e2683d11-d006-43fb-a90f-80122a9287f0, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:47,830 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, e2683d11-d006-43fb-a90f-80122a9287f0, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:48,049 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:48,058 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:48,059 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 41eb27eb-7125-4a54-8336-fbd9297a3e69, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:49:48,060 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 41eb27eb-7125-4a54-8336-fbd9297a3e69, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:48,065 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 41eb27eb-7125-4a54-8336-fbd9297a3e69, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:48,827 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:48,828 - INFO - __tests__.alter_compression.2335780  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 4855296, 'BlobCount': 384}}
2025-12-23 17:49:48,828 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:48,829 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, c2309358-f910-44fb-bd47-242fcab85093, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:49:48,830 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, c2309358-f910-44fb-bd47-242fcab85093, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 300000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:48,837 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, c2309358-f910-44fb-bd47-242fcab85093, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:50,351 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:50,352 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:50,353 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 438ba429-1d58-4586-b723-96ebe4eb13d1, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:49:50,354 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 438ba429-1d58-4586-b723-96ebe4eb13d1, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:50,355 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 438ba429-1d58-4586-b723-96ebe4eb13d1, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:50,585 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:50,586 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:50,587 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, c803f046-4233-41b9-8fa5-bbbaa04a46f2, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:49:50,589 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, c803f046-4233-41b9-8fa5-bbbaa04a46f2, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:50,590 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, c803f046-4233-41b9-8fa5-bbbaa04a46f2, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:51,189 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:51,190 - INFO - __tests__.alter_compression.2335780  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 6473728, 'BlobCount': 512}}
2025-12-23 17:49:51,191 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:51,191 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 179f30d6-06e0-45b7-8637-5a6c19ba46ad, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:49:51,197 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 179f30d6-06e0-45b7-8637-5a6c19ba46ad, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 400000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:51,199 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 179f30d6-06e0-45b7-8637-5a6c19ba46ad, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:52,944 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:53,060 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:53,129 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 7e717a4a-33b2-4fd6-8f8e-a172fcd7e298, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:49:53,130 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 7e717a4a-33b2-4fd6-8f8e-a172fcd7e298, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:53,132 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 7e717a4a-33b2-4fd6-8f8e-a172fcd7e298, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:53,704 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:53,705 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:53,706 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 2f9d057c-4e63-4116-887f-144e5adb5384, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:49:53,707 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 2f9d057c-4e63-4116-887f-144e5adb5384, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:53,709 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 2f9d057c-4e63-4116-887f-144e5adb5384, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:55,338 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:55,339 - INFO - __tests__.alter_compression.2335780  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 8092160, 'BlobCount': 640}}
2025-12-23 17:49:55,339 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:55,340 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, e15ffd5d-5ff2-44a8-92de-3667e8746d2c, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:49:55,345 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, e15ffd5d-5ff2-44a8-92de-3667e8746d2c, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 500000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:55,347 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, e15ffd5d-5ff2-44a8-92de-3667e8746d2c, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:56,486 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:56,487 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:56,488 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 3cab53b5-5046-4cb0-a8f1-c0ff874a129c, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:49:56,489 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 3cab53b5-5046-4cb0-a8f1-c0ff874a129c, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:56,497 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 3cab53b5-5046-4cb0-a8f1-c0ff874a129c, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:56,940 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:56,941 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:56,942 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 78491565-42f2-4a6d-afa2-e79a968593e3, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:49:56,943 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 78491565-42f2-4a6d-afa2-e79a968593e3, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:56,946 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 78491565-42f2-4a6d-afa2-e79a968593e3, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:58,134 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:58,134 - INFO - __tests__.alter_compression.2335780  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 9710592, 'BlobCount': 768}}
2025-12-23 17:49:58,135 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:58,136 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 521dfb81-98b1-4beb-9ff1-060a2f27def3, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:49:58,140 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 521dfb81-98b1-4beb-9ff1-060a2f27def3, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 600000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:58,142 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 521dfb81-98b1-4beb-9ff1-060a2f27def3, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:49:59,633 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:59,633 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:49:59,634 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 4e552b94-c40e-4144-aba5-ea7bb7a1a4fa, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:49:59,635 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 4e552b94-c40e-4144-aba5-ea7bb7a1a4fa, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:49:59,639 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 4e552b94-c40e-4144-aba5-ea7bb7a1a4fa, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:00,154 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:00,155 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:00,156 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 3fff0774-3eef-421f-9ad8-e6e0f17dca71, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:50:00,157 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 3fff0774-3eef-421f-9ad8-e6e0f17dca71, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:00,159 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 3fff0774-3eef-421f-9ad8-e6e0f17dca71, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:01,609 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:01,610 - INFO - __tests__.alter_compression.2335780  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 11329024, 'BlobCount': 896}}
2025-12-23 17:50:01,610 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:01,617 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 80584aa8-cac5-404e-9192-f3a195c9a42a, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:50:01,619 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 80584aa8-cac5-404e-9192-f3a195c9a42a, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 700000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:01,625 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 80584aa8-cac5-404e-9192-f3a195c9a42a, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:03,370 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:03,371 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:03,372 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 19852859-cfe5-49d5-ab62-f110be93e710, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:50:03,373 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 19852859-cfe5-49d5-ab62-f110be93e710, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:03,380 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 19852859-cfe5-49d5-ab62-f110be93e710, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:03,925 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:03,926 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:03,927 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 5811e268-9f8e-4737-8d0c-cc2f60d87705, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:50:03,928 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 5811e268-9f8e-4737-8d0c-cc2f60d87705, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:03,931 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 5811e268-9f8e-4737-8d0c-cc2f60d87705, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:04,842 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:04,843 - INFO - __tests__.alter_compression.2335780  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 12947456, 'BlobCount': 1024}}
2025-12-23 17:50:04,843 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:04,845 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 4e5f1031-c647-4ef0-a15b-03f69ae07a6d, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:50:04,846 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 4e5f1031-c647-4ef0-a15b-03f69ae07a6d, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 800000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:04,847 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 4e5f1031-c647-4ef0-a15b-03f69ae07a6d, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:06,377 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:06,448 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:06,462 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 2a192d85-9141-4ffa-b4cc-56ab4d036406, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:50:06,463 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 2a192d85-9141-4ffa-b4cc-56ab4d036406, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:06,477 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 2a192d85-9141-4ffa-b4cc-56ab4d036406, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:06,868 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:06,870 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:06,871 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, c2296f95-14cb-4282-94d4-2d0b7ccd906e, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:50:06,872 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, c2296f95-14cb-4282-94d4-2d0b7ccd906e, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:06,880 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, c2296f95-14cb-4282-94d4-2d0b7ccd906e, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:07,797 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:07,797 - INFO - __tests__.alter_compression.2335780  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 14565888, 'BlobCount': 1152}}
2025-12-23 17:50:07,798 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:07,799 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 9489695a-535d-40f3-a077-5087285a14f1, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:50:07,800 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 9489695a-535d-40f3-a077-5087285a14f1, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 900000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:07,811 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 9489695a-535d-40f3-a077-5087285a14f1, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:09,753 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:09,754 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:09,755 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, f3faa5b9-13c6-4dbd-baf5-231bf60fe9e6, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:50:09,756 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, f3faa5b9-13c6-4dbd-baf5-231bf60fe9e6, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:09,762 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, f3faa5b9-13c6-4dbd-baf5-231bf60fe9e6, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:10,370 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:10,371 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:10,372 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 3120b544-e8c8-402c-986e-25d90858f230, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:50:10,373 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 3120b544-e8c8-402c-986e-25d90858f230, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:10,375 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 3120b544-e8c8-402c-986e-25d90858f230, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:11,533 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:11,534 - INFO - __tests__.alter_compression.2335780  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 16184320, 'BlobCount': 1280}}
2025-12-23 17:50:11,534 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:11,535 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, bd872eb6-9254-40de-bd8f-249c6164719e, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:50:11,537 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, bd872eb6-9254-40de-bd8f-249c6164719e, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/off_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:11,538 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, bd872eb6-9254-40de-bd8f-249c6164719e, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:14,741 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:14,742 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:14,743 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 15319fa1-f856-455c-8a82-09a128fe5ce3, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:50:14,744 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 15319fa1-f856-455c-8a82-09a128fe5ce3, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:14,746 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 15319fa1-f856-455c-8a82-09a128fe5ce3, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:15,289 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:15,290 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:15,292 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 6cc0a2f8-ffcb-4e7e-beb3-c4e0cb5eedbb, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:50:15,293 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 6cc0a2f8-ffcb-4e7e-beb3-c4e0cb5eedbb, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:15,295 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 6cc0a2f8-ffcb-4e7e-beb3-c4e0cb5eedbb, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:15,745 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:15,746 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:15,747 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, a8875567-9e65-4f1d-87be-9f383501c086, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:50:15,750 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, a8875567-9e65-4f1d-87be-9f383501c086, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:15,752 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, a8875567-9e65-4f1d-87be-9f383501c086, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:21,437 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:31,480 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:31,481 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 07fa9efd-4054-41a2-ba26-fbfe7778fc9a, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:50:31,482 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 07fa9efd-4054-41a2-ba26-fbfe7778fc9a, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:31,484 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 07fa9efd-4054-41a2-ba26-fbfe7778fc9a, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:36,098 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:36,141 - INFO - root.2335780  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-12-23 17:50:36,142 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:36,142 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 1f88cf0f-1583-411d-8a68-abbc7f3a9bef, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:50:36,143 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 1f88cf0f-1583-411d-8a68-abbc7f3a9bef, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:36,145 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 1f88cf0f-1583-411d-8a68-abbc7f3a9bef, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:40,555 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:50,596 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:50,597 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 81837237-0446-48b9-87e0-9db81dc8d969, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:50:50,598 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 81837237-0446-48b9-87e0-9db81dc8d969, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:50:50,600 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 81837237-0446-48b9-87e0-9db81dc8d969, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:50:51,475 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:50:54,327 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335780  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-23 17:50:54,328 - DEBUG - ydb.connection.2335780  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 17:50:54,360 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335780  - context_resolve: Resolving endpoints for database /Root
2025-12-23 17:50:54,361 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ListEndpoints, ed427203-6921-454e-8429-1a8c27d4b604, localhost:63283): creating call state
2025-12-23 17:50:54,362 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ListEndpoints, ed427203-6921-454e-8429-1a8c27d4b604, localhost:63283): request = { database: "/Root" }
2025-12-23 17:50:54,367 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ListEndpoints, ed427203-6921-454e-8429-1a8c27d4b604, localhost:63283): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-yh5r7pxf7y.auto.internal" port: 63283 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-12-23 17:50:54,368 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335780  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-yh5r7pxf7y.auto.internal:63283, location 1, ssl: False>]>
2025-12-23 17:50:54,369 - DEBUG - ydb.connection.2335780  - close: Closing channel for endpoint localhost:63283
2025-12-23 17:51:01,479 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:01,480 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, c3680391-3b73-42f5-9e24-4a7ea527534c, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:01,482 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, c3680391-3b73-42f5-9e24-4a7ea527534c, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:01,483 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, c3680391-3b73-42f5-9e24-4a7ea527534c, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:02,155 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:02,159 - INFO - root.2335780  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8009216)
2025-12-23 17:51:02,161 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:02,162 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 928633ab-ff95-4359-90f8-ce46ca0b53fa, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:02,163 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 928633ab-ff95-4359-90f8-ce46ca0b53fa, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:02,164 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 928633ab-ff95-4359-90f8-ce46ca0b53fa, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:02,423 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:02,426 - INFO - ya.test.2335780  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_6_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 6])
2025-12-23 17:51:02,427 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:02,428 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, b396c264-ada4-42a7-8a30-1e76dd441a5c, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:02,429 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, b396c264-ada4-42a7-8a30-1e76dd441a5c, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_6_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 6)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:02,431 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, b396c264-ada4-42a7-8a30-1e76dd441a5c, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:05,121 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:05,122 - INFO - __tests__.alter_compression.2335780  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_6_compression created
2025-12-23 17:51:05,122 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:05,123 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 05be1a6b-af4c-4639-b553-12506fcde037, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:05,123 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 05be1a6b-af4c-4639-b553-12506fcde037, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_6_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:05,125 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 05be1a6b-af4c-4639-b553-12506fcde037, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:05,962 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:05,963 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:05,964 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 6c0ce6d0-4828-49aa-8fcd-18ff8c7fc45c, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:05,965 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 6c0ce6d0-4828-49aa-8fcd-18ff8c7fc45c, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:05,967 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 6c0ce6d0-4828-49aa-8fcd-18ff8c7fc45c, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:07,314 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:07,315 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:07,316 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 9b28cd93-2cd5-4aa5-b501-e21eb895dda0, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:07,316 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 9b28cd93-2cd5-4aa5-b501-e21eb895dda0, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:07,318 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 9b28cd93-2cd5-4aa5-b501-e21eb895dda0, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:08,143 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:08,144 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:08,145 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 66d6eae8-af42-41cd-b5f2-0376108e76f4, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:08,146 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 66d6eae8-af42-41cd-b5f2-0376108e76f4, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:08,149 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 66d6eae8-af42-41cd-b5f2-0376108e76f4, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:10,503 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:10,504 - INFO - __tests__.alter_compression.2335780  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318016, 'BlobCount': 128}}
2025-12-23 17:51:10,504 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:10,505 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, dce4a29c-0315-4860-b26e-1f94d5e03c53, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:10,506 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, dce4a29c-0315-4860-b26e-1f94d5e03c53, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:10,508 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, dce4a29c-0315-4860-b26e-1f94d5e03c53, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:11,731 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:11,732 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:11,733 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 3405a7c6-b121-47db-800a-67603bf78028, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:11,734 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 3405a7c6-b121-47db-800a-67603bf78028, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:11,736 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 3405a7c6-b121-47db-800a-67603bf78028, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:12,025 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:12,026 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:12,026 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 42b26544-33e6-46c8-b4d9-a3e3e9d39629, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:12,027 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 42b26544-33e6-46c8-b4d9-a3e3e9d39629, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:12,029 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 42b26544-33e6-46c8-b4d9-a3e3e9d39629, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:12,400 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:12,401 - INFO - __tests__.alter_compression.2335780  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 637312, 'BlobCount': 256}}
2025-12-23 17:51:12,402 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:12,403 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 464fce38-218d-4089-8d38-dfe1f44e9878, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:12,404 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 464fce38-218d-4089-8d38-dfe1f44e9878, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:12,409 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 464fce38-218d-4089-8d38-dfe1f44e9878, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:13,745 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:13,746 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:13,746 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 59d1443e-e47a-40cb-8323-fe65200955bc, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:13,747 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 59d1443e-e47a-40cb-8323-fe65200955bc, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:13,749 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 59d1443e-e47a-40cb-8323-fe65200955bc, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:14,031 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:14,031 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:14,032 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, b716972e-cd4e-47a8-b8d8-e40c4d6cb558, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:14,033 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, b716972e-cd4e-47a8-b8d8-e40c4d6cb558, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:14,035 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, b716972e-cd4e-47a8-b8d8-e40c4d6cb558, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:14,411 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:14,412 - INFO - __tests__.alter_compression.2335780  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 956352, 'BlobCount': 384}}
2025-12-23 17:51:14,413 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:14,414 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 45eb3950-bbdd-4095-8c8a-3bc165532dc2, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:14,415 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 45eb3950-bbdd-4095-8c8a-3bc165532dc2, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:14,416 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 45eb3950-bbdd-4095-8c8a-3bc165532dc2, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:15,755 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:15,756 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:15,757 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 1a23851d-0840-47cd-86bd-42f48c2f327b, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:15,758 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 1a23851d-0840-47cd-86bd-42f48c2f327b, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:15,760 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 1a23851d-0840-47cd-86bd-42f48c2f327b, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:16,045 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:16,046 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:16,047 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, c52593c6-ff61-4ee2-8ac4-3d37df1b5399, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:16,048 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, c52593c6-ff61-4ee2-8ac4-3d37df1b5399, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:16,050 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, c52593c6-ff61-4ee2-8ac4-3d37df1b5399, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:16,634 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:16,635 - INFO - __tests__.alter_compression.2335780  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1275712, 'BlobCount': 512}}
2025-12-23 17:51:16,635 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:16,636 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, bbca78a0-8b02-42c9-a6b3-9c09e80a86c2, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:16,637 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, bbca78a0-8b02-42c9-a6b3-9c09e80a86c2, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:16,639 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, bbca78a0-8b02-42c9-a6b3-9c09e80a86c2, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:18,378 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:18,399 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:18,400 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 1c242d70-c100-4cc3-a88f-b104556c4b03, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:18,401 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 1c242d70-c100-4cc3-a88f-b104556c4b03, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:18,404 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 1c242d70-c100-4cc3-a88f-b104556c4b03, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:18,745 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:18,746 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:18,747 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 07df46f5-97c6-418f-bf26-b848dc74a05e, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:18,748 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 07df46f5-97c6-418f-bf26-b848dc74a05e, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:18,757 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 07df46f5-97c6-418f-bf26-b848dc74a05e, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:19,248 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:19,248 - INFO - __tests__.alter_compression.2335780  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1594672, 'BlobCount': 640}}
2025-12-23 17:51:19,249 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:19,250 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, a99396ea-8543-427b-a8c8-5695457c09b7, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:19,251 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, a99396ea-8543-427b-a8c8-5695457c09b7, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:19,253 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, a99396ea-8543-427b-a8c8-5695457c09b7, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:20,716 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:20,717 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:20,717 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 80fdc89b-b9ce-4091-9507-07a165118310, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:20,718 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 80fdc89b-b9ce-4091-9507-07a165118310, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:20,719 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 80fdc89b-b9ce-4091-9507-07a165118310, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:21,008 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:21,009 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:21,010 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 9f2e240d-a7fc-4fca-833f-25dba0f0b301, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:21,011 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 9f2e240d-a7fc-4fca-833f-25dba0f0b301, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:21,013 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 9f2e240d-a7fc-4fca-833f-25dba0f0b301, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:21,586 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:21,597 - INFO - __tests__.alter_compression.2335780  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1913856, 'BlobCount': 768}}
2025-12-23 17:51:21,598 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:21,598 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, b27d2a10-382d-4f16-a333-3df1196f0571, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:21,600 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, b27d2a10-382d-4f16-a333-3df1196f0571, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:21,602 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, b27d2a10-382d-4f16-a333-3df1196f0571, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:22,991 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:22,992 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:22,992 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, bf8e5a46-4569-4854-8526-ed1a4bb000a1, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:22,993 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, bf8e5a46-4569-4854-8526-ed1a4bb000a1, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:22,995 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, bf8e5a46-4569-4854-8526-ed1a4bb000a1, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:23,496 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:23,497 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:23,498 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, af1514e7-d0f8-4d70-9939-b1c2ee35d763, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:23,499 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, af1514e7-d0f8-4d70-9939-b1c2ee35d763, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:23,505 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, af1514e7-d0f8-4d70-9939-b1c2ee35d763, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:24,269 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:24,270 - INFO - __tests__.alter_compression.2335780  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2232992, 'BlobCount': 896}}
2025-12-23 17:51:24,271 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:24,272 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 451f6915-86db-41eb-80b0-c38e941c7dc9, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:24,273 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 451f6915-86db-41eb-80b0-c38e941c7dc9, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:24,276 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 451f6915-86db-41eb-80b0-c38e941c7dc9, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:25,972 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:25,973 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:25,974 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, d05ec0f0-701e-425d-88f1-e55b332b6ea2, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:25,975 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, d05ec0f0-701e-425d-88f1-e55b332b6ea2, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:25,977 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, d05ec0f0-701e-425d-88f1-e55b332b6ea2, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:26,533 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:26,534 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:26,535 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 7dcb2027-5d51-460d-b3ff-6535afdb7711, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:26,536 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 7dcb2027-5d51-460d-b3ff-6535afdb7711, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:26,538 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 7dcb2027-5d51-460d-b3ff-6535afdb7711, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:27,501 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:27,502 - INFO - __tests__.alter_compression.2335780  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2552480, 'BlobCount': 1024}}
2025-12-23 17:51:27,502 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:27,503 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, a2b9f1c0-a3f6-470b-8a56-047c98162586, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:27,505 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, a2b9f1c0-a3f6-470b-8a56-047c98162586, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:27,507 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, a2b9f1c0-a3f6-470b-8a56-047c98162586, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:29,282 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:29,282 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:29,283 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, d678fb09-f6f6-4ee9-9ac0-ed409969160f, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:29,284 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, d678fb09-f6f6-4ee9-9ac0-ed409969160f, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:29,285 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, d678fb09-f6f6-4ee9-9ac0-ed409969160f, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:29,701 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:29,701 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:29,702 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 0d3decad-d9ea-45b7-b2df-cbefe0ceea52, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:29,703 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 0d3decad-d9ea-45b7-b2df-cbefe0ceea52, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:29,704 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 0d3decad-d9ea-45b7-b2df-cbefe0ceea52, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:30,555 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:30,565 - INFO - __tests__.alter_compression.2335780  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2871488, 'BlobCount': 1152}}
2025-12-23 17:51:30,565 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:30,566 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 0e135f78-2ae5-4c5d-b85f-49269b2e724e, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:30,567 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 0e135f78-2ae5-4c5d-b85f-49269b2e724e, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:30,576 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 0e135f78-2ae5-4c5d-b85f-49269b2e724e, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:32,374 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:32,374 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:32,375 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, eaf9a62c-99f5-4d9b-ba6f-0b249a324d61, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:32,376 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, eaf9a62c-99f5-4d9b-ba6f-0b249a324d61, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:32,378 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, eaf9a62c-99f5-4d9b-ba6f-0b249a324d61, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:32,998 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:32,999 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:32,999 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, e6e98d73-483e-46e5-9d59-24928b44f76a, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:33,001 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, e6e98d73-483e-46e5-9d59-24928b44f76a, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:33,002 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, e6e98d73-483e-46e5-9d59-24928b44f76a, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:34,470 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:34,471 - INFO - __tests__.alter_compression.2335780  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3190992, 'BlobCount': 1280}}
2025-12-23 17:51:34,471 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:34,472 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 6a06f834-c8a0-425f-afa3-d169698b3026, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:34,482 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 6a06f834-c8a0-425f-afa3-d169698b3026, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_6_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:34,483 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 6a06f834-c8a0-425f-afa3-d169698b3026, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:36,220 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:36,221 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:36,222 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 2a6dd67c-43c9-4315-87ce-0d3e582cbbe9, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:36,223 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 2a6dd67c-43c9-4315-87ce-0d3e582cbbe9, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:36,233 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 2a6dd67c-43c9-4315-87ce-0d3e582cbbe9, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:36,722 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:36,722 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:36,723 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, b64edef6-0f96-4ba2-a533-06d9ffa7f18b, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:36,726 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, b64edef6-0f96-4ba2-a533-06d9ffa7f18b, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:36,728 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, b64edef6-0f96-4ba2-a533-06d9ffa7f18b, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:37,313 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:37,314 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:37,315 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 62166cd4-ac97-407a-8804-c24d5a6d1331, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:37,316 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 62166cd4-ac97-407a-8804-c24d5a6d1331, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_6_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:37,318 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 62166cd4-ac97-407a-8804-c24d5a6d1331, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:43,618 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:53,693 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:53,695 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 57b540a0-690e-4e98-85bd-808563d15347, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:53,696 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 57b540a0-690e-4e98-85bd-808563d15347, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_6_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:53,697 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 57b540a0-690e-4e98-85bd-808563d15347, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:58,538 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:58,605 - INFO - root.2335780  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_6_compression`, volumes `value` (8000000, 1595496)
2025-12-23 17:51:58,606 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:58,606 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 6c00968a-daa8-4130-862e-afb395a5fd27, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:58,607 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 6c00968a-daa8-4130-862e-afb395a5fd27, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" 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_6_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:58,609 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 6c00968a-daa8-4130-862e-afb395a5fd27, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:51:59,025 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:59,026 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:51:59,026 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, ce18b98c-09b3-4511-a3ce-c30b5b431c25, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:51:59,027 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, ce18b98c-09b3-4511-a3ce-c30b5b431c25, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_6_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:51:59,029 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, ce18b98c-09b3-4511-a3ce-c30b5b431c25, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:52:02,836 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:52:12,884 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:52:12,886 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, b38e8c4e-7895-4c83-acef-15e5cfadf445, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:52:12,890 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, b38e8c4e-7895-4c83-acef-15e5cfadf445, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_6_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:52:12,893 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, b38e8c4e-7895-4c83-acef-15e5cfadf445, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:52:14,286 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:52:15,547 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335780  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-23 17:52:15,548 - DEBUG - ydb.connection.2335780  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 17:52:15,559 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335780  - context_resolve: Resolving endpoints for database /Root
2025-12-23 17:52:15,566 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ListEndpoints, 4b496e74-9277-41bd-a4d0-d11af7a280e2, localhost:63283): creating call state
2025-12-23 17:52:15,567 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ListEndpoints, 4b496e74-9277-41bd-a4d0-d11af7a280e2, localhost:63283): request = { database: "/Root" }
2025-12-23 17:52:15,575 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ListEndpoints, 4b496e74-9277-41bd-a4d0-d11af7a280e2, localhost:63283): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-yh5r7pxf7y.auto.internal" port: 63283 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-12-23 17:52:15,576 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.2335780  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-yh5r7pxf7y.auto.internal:63283, location 1, ssl: False>]>
2025-12-23 17:52:15,577 - DEBUG - ydb.connection.2335780  - close: Closing channel for endpoint localhost:63283
2025-12-23 17:52:24,303 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:52:24,304 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, dcf4bafd-f0f6-4ae6-bcc3-d2b4498aa62a, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:52:24,305 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, dcf4bafd-f0f6-4ae6-bcc3-d2b4498aa62a, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_6_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:52:24,307 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, dcf4bafd-f0f6-4ae6-bcc3-d2b4498aa62a, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:52:24,956 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:52:34,961 - DEBUG - ydb.query.pool.2335780  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:52:34,962 - DEBUG - ydb.connection.2335780  - _prepare_call: RpcState(ExecuteQuery, 3f0a5415-9125-46dd-b3c0-db3886e972ee, ghrun-yh5r7pxf7y.auto.internal:63283): creating call state
2025-12-23 17:52:34,963 - DEBUG - ydb.connection.2335780  - _log_request: RpcState(ExecuteQuery, 3f0a5415-9125-46dd-b3c0-db3886e972ee, ghrun-yh5r7pxf7y.auto.internal:63283): request = { session_id: "ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_6_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 17:52:34,969 - DEBUG - ydb.connection.2335780  - _log_response: RpcState(ExecuteQuery, 3f0a5415-9125-46dd-b3c0-db3886e972ee, ghrun-yh5r7pxf7y.auto.internal:63283): response = { <_MultiThreadedRendezvous object> }
2025-12-23 17:52:35,691 - DEBUG - ydb.query.pool.2335780  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWYzNDc1ZDctMTdlN2MxZWQtN2Q3NDBiNmQtNjhlZTU2NTU=
2025-12-23 17:52:35,695 - INFO - root.2335780  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_6_compression`, volumes `value` (8000000, 1466256)
2025-12-23 17:52:35,696 - INFO - root.2335780  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_6_compression` 8092160 / 1466256: 5.518927117774795
2025-12-23 17:52:35,708 - INFO - ya.test.2335780  - pytest_runtest_teardown: Test teardown
