2025-11-21 12:07:35,957 - INFO - ya.test.1714054  - pytest_runtest_setup: ####################################################################################################
2025-11-21 12:07:35,957 - INFO - ya.test.1714054  - pytest_runtest_setup: test_all_supported_compression[zstd_2_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 2]
2025-11-21 12:07:35,958 - INFO - ya.test.1714054  - pytest_runtest_setup: ####################################################################################################
2025-11-21 12:07:35,958 - INFO - ya.test.1714054  - pytest_runtest_setup: Test setup
2025-11-21 12:07:35,960 - DEBUG - ya.test.1714054  - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-21 12:07:35,961 - DEBUG - ya.test.1714054  - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-21 12:07:35,962 - DEBUG - ya.test.1714054  - execute: Executing '['/home/runner/.ya/build/build_root/vsfo/002923/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-21 12:07:35,979 - DEBUG - ya.test.1714054  - execute: Command pid: 1714544
2025-11-21 12:07:36,830 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714544) rc: 0
2025-11-21 12:07:36,831 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714544) elapsed time (sec): 0.8495385646820068
2025-11-21 12:07:36,832 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714544) idrss: 0
2025-11-21 12:07:36,832 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714544) inblock: 0
2025-11-21 12:07:36,832 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714544) isrss: 0
2025-11-21 12:07:36,832 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714544) ixrss: 0
2025-11-21 12:07:36,833 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714544) majflt: 0
2025-11-21 12:07:36,833 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714544) maxrss: 493456
2025-11-21 12:07:36,833 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714544) minflt: 45642
2025-11-21 12:07:36,834 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714544) msgrcv: 0
2025-11-21 12:07:36,834 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714544) msgsnd: 0
2025-11-21 12:07:36,834 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714544) nivcsw: 118
2025-11-21 12:07:36,835 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714544) nsignals: 0
2025-11-21 12:07:36,835 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714544) nswap: 0
2025-11-21 12:07:36,835 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714544) nvcsw: 13
2025-11-21 12:07:36,835 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714544) oublock: 8
2025-11-21 12:07:36,836 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714544) stime: 0.20317
2025-11-21 12:07:36,836 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714544) utime: 0.5415679999999999
2025-11-21 12:07:36,836 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714544) wtime: 0.868
2025-11-21 12:07:36,837 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714544) output:
Arc info:
    Branch: unknown-vcs-branch
    Commit: THIS_REVISION_IS_A_DUMMY
    Author: ordinal
    Summary: No VCS
    Last Changed Rev: -1
    Last Changed Date: 2015-03-14T06:05:35.000000Z
Other info:
    Build by: runner
    Top src dir: 
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-ts5cnd6jre    Host information: 
        Linux ghrun-ts5cnd6jre 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

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

2025-11-21 12:07:36,837 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714544) errors:

2025-11-21 12:07:36,838 - INFO - __tests__.base.1714054  - _setup_ydb: Arc info:
    Branch: unknown-vcs-branch
    Commit: THIS_REVISION_IS_A_DUMMY
    Author: ordinal
    Summary: No VCS
    Last Changed Rev: -1
    Last Changed Date: 2015-03-14T06:05:35.000000Z
Other info:
    Build by: runner
    Top src dir: 
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-ts5cnd6jre    Host information: 
        Linux ghrun-ts5cnd6jre 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

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

2025-11-21 12:07:36,972 - DEBUG - ya.test.1714054  - get_binary: Binary was found by /home/runner/.ya/build/build_root/vsfo/002923/ydb/apps/ydbd/ydbd
2025-11-21 12:07:36,973 - DEBUG - library.python.filelock.1714054  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/4558
2025-11-21 12:07:36,976 - DEBUG - ydb.tests.library.harness.kikimr_runner.1714054  - start: Working directory: /home/runner/.ya/build/build_root/vsfo/002923/r3tmp/kikimr_cluster_wht2r9sy
2025-11-21 12:07:37,019 - DEBUG - ya.test.1714054  - get_binary: Binary was found by /home/runner/.ya/build/build_root/vsfo/002923/ydb/apps/ydbd/ydbd
2025-11-21 12:07:37,020 - DEBUG - library.python.filelock.1714054  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/15670
2025-11-21 12:07:37,021 - DEBUG - library.python.filelock.1714054  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/10895
2025-11-21 12:07:37,021 - DEBUG - library.python.filelock.1714054  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/14497
2025-11-21 12:07:37,022 - DEBUG - library.python.filelock.1714054  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/12459
2025-11-21 12:07:37,023 - INFO - ydb.tests.library.harness.kikimr_runner.1714054  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/vsfo/002923/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk5/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_2_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.2/cluster/kikimr_configs"
2025-11-21 12:07:37,024 - INFO - ydb.tests.library.harness.kikimr_runner.1714054  - __make_run_command: Final command: /home/runner/.ya/build/build_root/vsfo/002923/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/vsfo/002923/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk5/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_2_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.2/cluster/node_1/logfile_i3vn69er.log --grpc-port=15670 --mon-port=10895 --ic-port=4558
2025-11-21 12:07:37,024 - DEBUG - ydb.tests.library.harness.kikimr_runner.1714054  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:15670/1, disk_size 68719476736
2025-11-21 12:07:37,025 - INFO - ydb.tests.library.harness.kikimr_runner.1714054  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/vsfo/002923/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk5/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_2_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.2/cluster/kikimr_configs"
2025-11-21 12:07:37,025 - INFO - ydb.tests.library.harness.kikimr_runner.1714054  - __make_run_command: Final command: /home/runner/.ya/build/build_root/vsfo/002923/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/vsfo/002923/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk5/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_2_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.2/cluster/node_1/logfile_i3vn69er.log --grpc-port=15670 --mon-port=10895 --ic-port=4558
2025-11-21 12:07:37,026 - DEBUG - ya.test.1714054  - execute: Executing '('/home/runner/.ya/build/build_root/vsfo/002923/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/vsfo/002923/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk5/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_2_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.2/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/vsfo/002923/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk5/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_2_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.2/cluster/node_1/logfile_i3vn69er.log', '--grpc-port=15670', '--mon-port=10895', '--ic-port=4558')' in '/home/runner/.ya/build/build_root/vsfo/002923/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk5/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_2_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.2/cluster/node_1' (no wait)
2025-11-21 12:07:37,029 - DEBUG - ya.test.1714054  - execute: Command pid: 1714735
2025-11-21 12:07:37,030 - INFO - ydb.tests.library.harness.kikimr_runner.1714054  - start: Started node localhost:15670/1
2025-11-21 12:07:37,031 - DEBUG - ya.test.1714054  - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-21 12:07:37,032 - DEBUG - ya.test.1714054  - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-21 12:07:37,033 - DEBUG - ya.test.1714054  - execute: Executing '['/home/runner/.ya/build/build_root/vsfo/002923/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-21 12:07:37,036 - DEBUG - ya.test.1714054  - execute: Command pid: 1714737
2025-11-21 12:07:37,846 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714737) rc: 0
2025-11-21 12:07:37,846 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714737) elapsed time (sec): 0.8083274364471436
2025-11-21 12:07:37,847 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714737) idrss: 0
2025-11-21 12:07:37,847 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714737) inblock: 0
2025-11-21 12:07:37,847 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714737) isrss: 0
2025-11-21 12:07:37,848 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714737) ixrss: 0
2025-11-21 12:07:37,848 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714737) majflt: 0
2025-11-21 12:07:37,848 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714737) maxrss: 499336
2025-11-21 12:07:37,849 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714737) minflt: 45675
2025-11-21 12:07:37,849 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714737) msgrcv: 0
2025-11-21 12:07:37,849 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714737) msgsnd: 0
2025-11-21 12:07:37,849 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714737) nivcsw: 88
2025-11-21 12:07:37,850 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714737) nsignals: 0
2025-11-21 12:07:37,850 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714737) nswap: 0
2025-11-21 12:07:37,850 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714737) nvcsw: 14
2025-11-21 12:07:37,850 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714737) oublock: 8
2025-11-21 12:07:37,851 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714737) stime: 0.241314
2025-11-21 12:07:37,851 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714737) utime: 0.49461299999999997
2025-11-21 12:07:37,851 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714737) wtime: 0.812
2025-11-21 12:07:37,852 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714737) output:
Arc info:
    Branch: unknown-vcs-branch
    Commit: THIS_REVISION_IS_A_DUMMY
    Author: ordinal
    Summary: No VCS
    Last Changed Rev: -1
    Last Changed Date: 2015-03-14T06:05:35.000000Z
Other info:
    Build by: runner
    Top src dir: 
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-ts5cnd6jre    Host information: 
        Linux ghrun-ts5cnd6jre 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

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

2025-11-21 12:07:37,852 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1714737) errors:

2025-11-21 12:07:37,853 - INFO - ydb.tests.library.harness.kikimr_runner.1714054  - start: Node 1 version:
Arc info:
    Branch: unknown-vcs-branch
    Commit: THIS_REVISION_IS_A_DUMMY
    Author: ordinal
    Summary: No VCS
    Last Changed Rev: -1
    Last Changed Date: 2015-03-14T06:05:35.000000Z
Other info:
    Build by: runner
    Top src dir: 
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-ts5cnd6jre    Host information: 
        Linux ghrun-ts5cnd6jre 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64
2025-11-21 12:07:40,075 - DEBUG - ya.test.1714054  - get_binary: Binary was found by /home/runner/.ya/build/build_root/vsfo/002923/ydb/apps/ydbd/ydbd
2025-11-21 12:07:40,076 - DEBUG - ydb.tests.library.harness.kikimr_runner.1714054  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/vsfo/002923/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:15670', '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: 4558\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-21 12:07:40,077 - DEBUG - ya.test.1714054  - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-21 12:07:40,078 - DEBUG - ya.test.1714054  - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-21 12:07:40,078 - DEBUG - ya.test.1714054  - execute: Executing '['/home/runner/.ya/build/build_root/vsfo/002923/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:15670', '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: 4558\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-21 12:07:40,088 - DEBUG - ya.test.1714054  - execute: Command pid: 1715206
2025-11-21 12:07:40,966 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715206) rc: 0
2025-11-21 12:07:40,967 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715206) elapsed time (sec): 0.8771872520446777
2025-11-21 12:07:40,967 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715206) idrss: 0
2025-11-21 12:07:40,968 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715206) inblock: 0
2025-11-21 12:07:40,968 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715206) isrss: 0
2025-11-21 12:07:40,968 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715206) ixrss: 0
2025-11-21 12:07:40,969 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715206) majflt: 0
2025-11-21 12:07:40,969 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715206) maxrss: 545356
2025-11-21 12:07:40,969 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715206) minflt: 51780
2025-11-21 12:07:40,970 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715206) msgrcv: 0
2025-11-21 12:07:40,970 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715206) msgsnd: 0
2025-11-21 12:07:40,970 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715206) nivcsw: 168
2025-11-21 12:07:40,971 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715206) nsignals: 0
2025-11-21 12:07:40,971 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715206) nswap: 0
2025-11-21 12:07:40,971 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715206) nvcsw: 649
2025-11-21 12:07:40,972 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715206) oublock: 8
2025-11-21 12:07:40,972 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715206) stime: 0.219745
2025-11-21 12:07:40,972 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715206) utime: 0.599699
2025-11-21 12:07:40,973 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715206) wtime: 0.887
2025-11-21 12:07:40,973 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715206) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-21 12:07:40,973 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715206) errors:

2025-11-21 12:07:40,975 - DEBUG - ya.test.1714054  - get_binary: Binary was found by /home/runner/.ya/build/build_root/vsfo/002923/ydb/apps/ydbd/ydbd
2025-11-21 12:07:40,975 - DEBUG - ydb.tests.library.harness.kikimr_runner.1714054  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/vsfo/002923/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:15670', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']
2025-11-21 12:07:40,977 - DEBUG - ya.test.1714054  - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-21 12:07:40,977 - DEBUG - ya.test.1714054  - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-21 12:07:40,978 - DEBUG - ya.test.1714054  - execute: Executing '['/home/runner/.ya/build/build_root/vsfo/002923/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:15670', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-21 12:07:40,991 - DEBUG - ya.test.1714054  - execute: Command pid: 1715464
2025-11-21 12:07:41,892 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715464) rc: 0
2025-11-21 12:07:41,892 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715464) elapsed time (sec): 0.8992762565612793
2025-11-21 12:07:41,893 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715464) idrss: 0
2025-11-21 12:07:41,893 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715464) inblock: 0
2025-11-21 12:07:41,893 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715464) isrss: 0
2025-11-21 12:07:41,893 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715464) ixrss: 0
2025-11-21 12:07:41,894 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715464) majflt: 0
2025-11-21 12:07:41,894 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715464) maxrss: 546340
2025-11-21 12:07:41,894 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715464) minflt: 51874
2025-11-21 12:07:41,895 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715464) msgrcv: 0
2025-11-21 12:07:41,895 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715464) msgsnd: 0
2025-11-21 12:07:41,896 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715464) nivcsw: 121
2025-11-21 12:07:41,896 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715464) nsignals: 0
2025-11-21 12:07:41,897 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715464) nswap: 0
2025-11-21 12:07:41,897 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715464) nvcsw: 900
2025-11-21 12:07:41,897 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715464) oublock: 8
2025-11-21 12:07:41,898 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715464) stime: 0.242786
2025-11-21 12:07:41,898 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715464) utime: 0.5807939999999999
2025-11-21 12:07:41,898 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715464) wtime: 0.913
2025-11-21 12:07:41,899 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715464) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-11-21 12:07:41,899 - DEBUG - ya.test.1714054  - _save_outputs: Command (pid 1715464) errors:

2025-11-21 12:07:41,900 - INFO - ydb.tests.library.harness.kikimr_runner.1714054  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-21 12:07:42,012 - INFO - ydb.tests.library.harness.kikimr_runner.1714054  - __run: Cluster started and initialized
2025-11-21 12:07:42,057 - DEBUG - ydb.connection.1714054  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-21 12:07:42,061 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1714054  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-21 12:07:42,062 - DEBUG - ydb.connection.1714054  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-21 12:07:42,089 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1714054  - context_resolve: Resolving endpoints for database /Root
2025-11-21 12:07:42,090 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ListEndpoints, 71a9f442-e8f1-4a4e-830f-4fd3773c5ad3, localhost:15670): creating call state
2025-11-21 12:07:42,091 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ListEndpoints, 71a9f442-e8f1-4a4e-830f-4fd3773c5ad3, localhost:15670): request = { database: "/Root" }
2025-11-21 12:07:42,102 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ListEndpoints, 71a9f442-e8f1-4a4e-830f-4fd3773c5ad3, localhost:15670): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-ts5cnd6jre.auto.internal" port: 15670 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-11-21 12:07:42,104 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1714054  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-ts5cnd6jre.auto.internal:15670, location 1, ssl: False>]>
2025-11-21 12:07:42,105 - DEBUG - ydb.connection.1714054  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-21 12:07:42,132 - DEBUG - ydb.connection.1714054  - close: Closing channel for endpoint localhost:15670
2025-11-21 12:07:42,135 - DEBUG - ydb.query.pool.1714054  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-21 12:07:42,136 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(CreateSession, cf6a98bb-2eb5-45c5-8c10-adca80cd8a5c, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:07:42,137 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(CreateSession, cf6a98bb-2eb5-45c5-8c10-adca80cd8a5c, ghrun-ts5cnd6jre.auto.internal:15670): request = {  }
2025-11-21 12:07:42,145 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(CreateSession, cf6a98bb-2eb5-45c5-8c10-adca80cd8a5c, ghrun-ts5cnd6jre.auto.internal:15670): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" node_id: 1 }
2025-11-21 12:07:42,146 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(AttachSession, b9d810b3-729d-4cfb-a5d5-35c855a62d69, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:07:42,147 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(AttachSession, b9d810b3-729d-4cfb-a5d5-35c855a62d69, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" }
2025-11-21 12:07:42,150 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(AttachSession, b9d810b3-729d-4cfb-a5d5-35c855a62d69, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:07:42,153 - DEBUG - ydb.query.pool.1714054  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:42,154 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, faacc4dd-689f-4fa9-97d0-080b2ef53343, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:07:42,155 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, faacc4dd-689f-4fa9-97d0-080b2ef53343, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/off_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"off\")\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:07:42,156 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, faacc4dd-689f-4fa9-97d0-080b2ef53343, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:07:44,615 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:44,616 - INFO - __tests__.alter_compression.1714054  - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-11-21 12:07:44,617 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:44,618 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 8d777ee1-77a1-4a7e-8729-187045d69670, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:07:44,618 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 8d777ee1-77a1-4a7e-8729-187045d69670, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/off_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:07:44,620 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 8d777ee1-77a1-4a7e-8729-187045d69670, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:07:45,498 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:45,499 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:45,499 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 854b5495-8756-4c7d-bb34-ba3a14e201ec, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:07:45,500 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 854b5495-8756-4c7d-bb34-ba3a14e201ec, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 0;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:07:45,508 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 854b5495-8756-4c7d-bb34-ba3a14e201ec, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:07:46,546 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:46,547 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:46,548 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 10e4cd56-22e9-42e0-b0b5-d9899557eebe, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:07:46,549 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 10e4cd56-22e9-42e0-b0b5-d9899557eebe, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:07:46,551 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 10e4cd56-22e9-42e0-b0b5-d9899557eebe, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:07:47,221 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:47,222 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:47,223 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 3be62896-375e-4b48-be3b-3ed743c7b993, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:07:47,224 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 3be62896-375e-4b48-be3b-3ed743c7b993, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:07:47,226 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 3be62896-375e-4b48-be3b-3ed743c7b993, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:07:48,588 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:48,589 - INFO - __tests__.alter_compression.1714054  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 1618432, 'BlobCount': 128}}
2025-11-21 12:07:48,589 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:48,590 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 2aac7756-4468-40e8-9e97-34d24a388b4a, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:07:48,591 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 2aac7756-4468-40e8-9e97-34d24a388b4a, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 100000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:07:48,592 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 2aac7756-4468-40e8-9e97-34d24a388b4a, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:07:49,381 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:49,382 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:49,383 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, e4b183b3-8e4d-4d3a-a96d-b0d003f40847, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:07:49,384 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, e4b183b3-8e4d-4d3a-a96d-b0d003f40847, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:07:49,385 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, e4b183b3-8e4d-4d3a-a96d-b0d003f40847, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:07:49,582 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:49,583 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:49,584 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, d2be3af1-4275-44fc-b902-c1c0e0723e1e, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:07:49,585 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, d2be3af1-4275-44fc-b902-c1c0e0723e1e, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:07:49,587 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, d2be3af1-4275-44fc-b902-c1c0e0723e1e, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:07:49,876 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:49,877 - INFO - __tests__.alter_compression.1714054  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 3236864, 'BlobCount': 256}}
2025-11-21 12:07:49,877 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:49,878 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, e6594179-0b3d-43f4-a088-947bfaf695f0, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:07:49,879 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, e6594179-0b3d-43f4-a088-947bfaf695f0, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 200000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:07:49,880 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, e6594179-0b3d-43f4-a088-947bfaf695f0, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:07:50,777 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:50,778 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:50,778 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, ce280e40-31e3-474c-87ec-2a5be32b8601, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:07:50,779 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, ce280e40-31e3-474c-87ec-2a5be32b8601, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:07:50,781 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, ce280e40-31e3-474c-87ec-2a5be32b8601, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:07:50,968 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:50,969 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:50,969 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, a010585e-7118-4e8e-bbe1-e11576017c35, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:07:50,970 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, a010585e-7118-4e8e-bbe1-e11576017c35, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:07:50,972 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, a010585e-7118-4e8e-bbe1-e11576017c35, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:07:51,305 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:51,306 - INFO - __tests__.alter_compression.1714054  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 4855296, 'BlobCount': 384}}
2025-11-21 12:07:51,307 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:51,307 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, ca2289f1-53e2-4715-8501-8ec17b424c44, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:07:51,308 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, ca2289f1-53e2-4715-8501-8ec17b424c44, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 300000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:07:51,311 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, ca2289f1-53e2-4715-8501-8ec17b424c44, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:07:52,256 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:52,257 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:52,258 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, c7a5b7e1-2b39-4b3e-b3f8-0571bd499f57, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:07:52,259 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, c7a5b7e1-2b39-4b3e-b3f8-0571bd499f57, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:07:52,260 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, c7a5b7e1-2b39-4b3e-b3f8-0571bd499f57, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:07:52,489 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:52,489 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:52,490 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 2c5c4200-999d-43ec-8ac5-99d3b24b37a0, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:07:52,491 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 2c5c4200-999d-43ec-8ac5-99d3b24b37a0, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:07:52,494 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 2c5c4200-999d-43ec-8ac5-99d3b24b37a0, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:07:52,966 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:52,966 - INFO - __tests__.alter_compression.1714054  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 6473728, 'BlobCount': 512}}
2025-11-21 12:07:52,967 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:52,968 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, a8adae78-0fdf-412d-b330-b5d3d6f3ed1b, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:07:52,969 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, a8adae78-0fdf-412d-b330-b5d3d6f3ed1b, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 400000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:07:52,970 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, a8adae78-0fdf-412d-b330-b5d3d6f3ed1b, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:07:54,068 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:54,069 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:54,070 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 57879b2f-2171-4c5d-8eb5-95e7a53b7d8d, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:07:54,071 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 57879b2f-2171-4c5d-8eb5-95e7a53b7d8d, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:07:54,072 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 57879b2f-2171-4c5d-8eb5-95e7a53b7d8d, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:07:54,440 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:54,441 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:54,442 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 31f59664-0b5e-4d75-a253-bfb56b0d66b2, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:07:54,443 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 31f59664-0b5e-4d75-a253-bfb56b0d66b2, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:07:54,444 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 31f59664-0b5e-4d75-a253-bfb56b0d66b2, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:07:55,053 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:55,053 - INFO - __tests__.alter_compression.1714054  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 8092160, 'BlobCount': 640}}
2025-11-21 12:07:55,054 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:55,055 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 357f8650-3339-4333-9da4-8800b787f3d3, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:07:55,056 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 357f8650-3339-4333-9da4-8800b787f3d3, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 500000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:07:55,057 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 357f8650-3339-4333-9da4-8800b787f3d3, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:07:56,067 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:56,068 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:56,069 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 16b12b0c-3350-42c4-a0ce-6f8e420d6588, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:07:56,070 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 16b12b0c-3350-42c4-a0ce-6f8e420d6588, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:07:56,073 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 16b12b0c-3350-42c4-a0ce-6f8e420d6588, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:07:56,458 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:56,459 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:56,459 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, d104ef6d-171a-4e94-b8d4-e880ed804729, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:07:56,460 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, d104ef6d-171a-4e94-b8d4-e880ed804729, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:07:56,462 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, d104ef6d-171a-4e94-b8d4-e880ed804729, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:07:57,038 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:57,038 - INFO - __tests__.alter_compression.1714054  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 9710592, 'BlobCount': 768}}
2025-11-21 12:07:57,039 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:57,047 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, b00f79a5-91ed-40e2-9091-d2f755e47e93, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:07:57,048 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, b00f79a5-91ed-40e2-9091-d2f755e47e93, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 600000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:07:57,049 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, b00f79a5-91ed-40e2-9091-d2f755e47e93, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:07:58,247 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:58,248 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:58,249 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, d9ff595a-6a1d-4af4-aa87-3654c9ff8784, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:07:58,250 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, d9ff595a-6a1d-4af4-aa87-3654c9ff8784, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:07:58,251 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, d9ff595a-6a1d-4af4-aa87-3654c9ff8784, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:07:58,561 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:58,562 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:58,563 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 2a6003f2-02d8-4837-84da-a9b4f3cfdbed, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:07:58,564 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 2a6003f2-02d8-4837-84da-a9b4f3cfdbed, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:07:58,565 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 2a6003f2-02d8-4837-84da-a9b4f3cfdbed, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:07:59,273 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:59,274 - INFO - __tests__.alter_compression.1714054  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 11329024, 'BlobCount': 896}}
2025-11-21 12:07:59,275 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:07:59,276 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 241df6ca-3482-43fe-a6de-a4ef70c3f36f, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:07:59,277 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 241df6ca-3482-43fe-a6de-a4ef70c3f36f, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 700000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:07:59,278 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 241df6ca-3482-43fe-a6de-a4ef70c3f36f, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:00,449 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:00,449 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:00,450 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 04807bf9-9df9-4f05-b117-8ebf5d20f8c3, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:08:00,451 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 04807bf9-9df9-4f05-b117-8ebf5d20f8c3, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:08:00,453 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 04807bf9-9df9-4f05-b117-8ebf5d20f8c3, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:00,777 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:00,778 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:00,779 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, bcd7e0e8-e63b-4590-b79f-910824d6d3c3, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:08:00,780 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, bcd7e0e8-e63b-4590-b79f-910824d6d3c3, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:08:00,782 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, bcd7e0e8-e63b-4590-b79f-910824d6d3c3, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:01,473 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:01,474 - INFO - __tests__.alter_compression.1714054  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 12947456, 'BlobCount': 1024}}
2025-11-21 12:08:01,475 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:01,475 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, f0a6539d-6d01-4857-8119-ecd884fc66ad, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:08:01,476 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, f0a6539d-6d01-4857-8119-ecd884fc66ad, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 800000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:08:01,484 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, f0a6539d-6d01-4857-8119-ecd884fc66ad, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:02,688 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:02,689 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:02,690 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 4e109ac5-2018-4893-b87b-cc2ff772406a, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:08:02,691 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 4e109ac5-2018-4893-b87b-cc2ff772406a, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:08:02,692 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 4e109ac5-2018-4893-b87b-cc2ff772406a, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:02,947 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:02,948 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:02,949 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 09be8411-d34f-410e-9be1-0743341fa689, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:08:02,950 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 09be8411-d34f-410e-9be1-0743341fa689, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:08:02,955 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 09be8411-d34f-410e-9be1-0743341fa689, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:03,589 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:03,590 - INFO - __tests__.alter_compression.1714054  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 14565888, 'BlobCount': 1152}}
2025-11-21 12:08:03,590 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:03,591 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 106a3bea-9238-487a-9bc6-ae3041a21351, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:08:03,592 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 106a3bea-9238-487a-9bc6-ae3041a21351, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 900000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:08:03,593 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 106a3bea-9238-487a-9bc6-ae3041a21351, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:04,675 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:04,676 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:04,677 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 11c57937-e51f-4610-9d49-23a4e756303f, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:08:04,678 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 11c57937-e51f-4610-9d49-23a4e756303f, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:08:04,679 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 11c57937-e51f-4610-9d49-23a4e756303f, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:04,993 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:04,994 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:04,994 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 370e322e-377f-432c-9003-b69470e42a2a, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:08:04,996 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 370e322e-377f-432c-9003-b69470e42a2a, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:08:04,997 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 370e322e-377f-432c-9003-b69470e42a2a, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:05,841 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:05,842 - INFO - __tests__.alter_compression.1714054  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 16184320, 'BlobCount': 1280}}
2025-11-21 12:08:05,842 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:05,843 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 5be6ddc4-5dc1-4a8e-8b5c-c9a5e9c9a407, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:08:05,844 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 5be6ddc4-5dc1-4a8e-8b5c-c9a5e9c9a407, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/off_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:08:05,845 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 5be6ddc4-5dc1-4a8e-8b5c-c9a5e9c9a407, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:07,249 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:07,250 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:07,251 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 8fac8b2c-8d26-4de7-82e4-118dcd3c9d1b, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:08:07,252 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 8fac8b2c-8d26-4de7-82e4-118dcd3c9d1b, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:08:07,253 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 8fac8b2c-8d26-4de7-82e4-118dcd3c9d1b, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:07,876 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:07,877 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:07,877 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 5e645ac0-39bd-495b-8c89-a2339da139a6, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:08:07,878 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 5e645ac0-39bd-495b-8c89-a2339da139a6, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:08:07,884 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 5e645ac0-39bd-495b-8c89-a2339da139a6, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:08,252 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:08,252 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:08,253 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 706e47aa-656c-499a-93a5-9a5e774a5b95, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:08:08,254 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 706e47aa-656c-499a-93a5-9a5e774a5b95, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:08:08,256 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 706e47aa-656c-499a-93a5-9a5e774a5b95, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:12,796 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:22,835 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:22,836 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, ca8707be-55cd-41e3-8a24-c24251423807, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:08:22,837 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, ca8707be-55cd-41e3-8a24-c24251423807, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:08:22,839 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, ca8707be-55cd-41e3-8a24-c24251423807, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:27,233 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:27,290 - INFO - root.1714054  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-21 12:08:27,293 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:27,295 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, b525627e-7905-45cb-9e83-468d96c4efb3, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:08:27,296 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, b525627e-7905-45cb-9e83-468d96c4efb3, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:08:27,298 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, b525627e-7905-45cb-9e83-468d96c4efb3, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:34,588 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:44,706 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:08:44,707 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 2d058936-9167-4083-9ed6-dc3f0b3e0aa5, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:08:44,708 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 2d058936-9167-4083-9ed6-dc3f0b3e0aa5, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:08:44,710 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 2d058936-9167-4083-9ed6-dc3f0b3e0aa5, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:08:51,630 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:01,688 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:01,688 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, c03533ba-1509-43ca-a58b-1e7b89efcd95, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:01,689 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, c03533ba-1509-43ca-a58b-1e7b89efcd95, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:01,691 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, c03533ba-1509-43ca-a58b-1e7b89efcd95, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:02,938 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:12,948 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:12,949 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 91dce588-15f5-4eb8-9f43-8ecf802cb85c, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:12,950 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 91dce588-15f5-4eb8-9f43-8ecf802cb85c, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:12,967 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 91dce588-15f5-4eb8-9f43-8ecf802cb85c, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:14,176 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:14,197 - INFO - root.1714054  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8009216)
2025-11-21 12:09:14,197 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:14,198 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 200c86e4-8921-4a6b-9f7d-54e7bf761f42, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:14,199 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 200c86e4-8921-4a6b-9f7d-54e7bf761f42, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:14,201 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 200c86e4-8921-4a6b-9f7d-54e7bf761f42, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:14,697 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:14,700 - INFO - ya.test.1714054  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_2_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 2])
2025-11-21 12:09:14,701 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:14,701 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, b0e53bd9-d446-4779-b695-00fb17d371b7, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:14,702 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, b0e53bd9-d446-4779-b695-00fb17d371b7, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_2_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 2)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:14,706 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, b0e53bd9-d446-4779-b695-00fb17d371b7, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:18,574 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1714054  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-21 12:09:18,575 - DEBUG - ydb.connection.1714054  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-21 12:09:18,611 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1714054  - context_resolve: Resolving endpoints for database /Root
2025-11-21 12:09:18,612 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ListEndpoints, 393cf8bb-b676-4e47-8554-1d28e2c5d625, localhost:15670): creating call state
2025-11-21 12:09:18,612 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ListEndpoints, 393cf8bb-b676-4e47-8554-1d28e2c5d625, localhost:15670): request = { database: "/Root" }
2025-11-21 12:09:18,618 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ListEndpoints, 393cf8bb-b676-4e47-8554-1d28e2c5d625, localhost:15670): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-ts5cnd6jre.auto.internal" port: 15670 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-11-21 12:09:18,619 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1714054  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-ts5cnd6jre.auto.internal:15670, location 1, ssl: False>]>
2025-11-21 12:09:18,623 - DEBUG - ydb.connection.1714054  - close: Closing channel for endpoint localhost:15670
2025-11-21 12:09:19,295 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:19,296 - INFO - __tests__.alter_compression.1714054  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_2_compression created
2025-11-21 12:09:19,297 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:19,297 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 123773dd-e701-4582-a7f4-4ec9417cc2db, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:19,298 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 123773dd-e701-4582-a7f4-4ec9417cc2db, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_2_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:19,299 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 123773dd-e701-4582-a7f4-4ec9417cc2db, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:20,728 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:20,729 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:20,730 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, e41b55d2-fdb0-4c43-bca2-31495fe157eb, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:20,731 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, e41b55d2-fdb0-4c43-bca2-31495fe157eb, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:20,732 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, e41b55d2-fdb0-4c43-bca2-31495fe157eb, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:22,532 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:22,533 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:22,534 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 98b841f5-bc7f-4c98-a2e3-ff76927f64cf, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:22,534 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 98b841f5-bc7f-4c98-a2e3-ff76927f64cf, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:22,540 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 98b841f5-bc7f-4c98-a2e3-ff76927f64cf, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:23,841 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:23,842 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:23,842 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 247b3ee1-fafa-4234-a90a-9fafec466beb, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:23,843 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 247b3ee1-fafa-4234-a90a-9fafec466beb, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:23,852 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 247b3ee1-fafa-4234-a90a-9fafec466beb, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:26,368 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:26,369 - INFO - __tests__.alter_compression.1714054  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_2_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318880, 'BlobCount': 128}}
2025-11-21 12:09:26,369 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:26,370 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, c70db9ed-58be-4a9c-adef-61448ccbbd6b, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:26,371 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, c70db9ed-58be-4a9c-adef-61448ccbbd6b, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:26,373 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, c70db9ed-58be-4a9c-adef-61448ccbbd6b, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:27,834 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:27,835 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:27,836 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 5640c00c-dd63-4451-9e02-d4874290d525, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:27,837 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 5640c00c-dd63-4451-9e02-d4874290d525, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:27,839 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 5640c00c-dd63-4451-9e02-d4874290d525, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:28,412 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:28,413 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:28,413 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, de49a027-cb2d-49d7-8ea4-23f6d6246db0, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:28,414 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, de49a027-cb2d-49d7-8ea4-23f6d6246db0, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:28,419 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, de49a027-cb2d-49d7-8ea4-23f6d6246db0, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:28,942 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:28,943 - INFO - __tests__.alter_compression.1714054  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_2_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 638656, 'BlobCount': 256}}
2025-11-21 12:09:28,943 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:28,944 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 53cddb38-69b6-41d4-b6b2-551afd270ad0, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:28,945 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 53cddb38-69b6-41d4-b6b2-551afd270ad0, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:28,948 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 53cddb38-69b6-41d4-b6b2-551afd270ad0, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:30,769 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:30,770 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:30,771 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 0f695b62-a3d9-4bd5-9304-29ab36cb24c1, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:30,772 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 0f695b62-a3d9-4bd5-9304-29ab36cb24c1, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:30,773 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 0f695b62-a3d9-4bd5-9304-29ab36cb24c1, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:31,201 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:31,202 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:31,203 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, b13a7c5f-ef11-43b2-af15-cdb92a31c9f2, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:31,204 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, b13a7c5f-ef11-43b2-af15-cdb92a31c9f2, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:31,208 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, b13a7c5f-ef11-43b2-af15-cdb92a31c9f2, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:31,909 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:31,910 - INFO - __tests__.alter_compression.1714054  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_2_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 957984, 'BlobCount': 384}}
2025-11-21 12:09:31,910 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:31,911 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, b5838fd1-784f-408c-8cda-d6abec96dda1, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:31,924 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, b5838fd1-784f-408c-8cda-d6abec96dda1, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:31,926 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, b5838fd1-784f-408c-8cda-d6abec96dda1, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:33,677 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:33,678 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:33,678 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 6feada28-5319-4ea8-ac21-0f928b2fd4c5, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:33,679 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 6feada28-5319-4ea8-ac21-0f928b2fd4c5, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:33,680 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 6feada28-5319-4ea8-ac21-0f928b2fd4c5, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:34,234 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:34,235 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:34,236 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 2239efb3-21c7-494f-8cc5-0203ef12ecf9, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:34,237 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 2239efb3-21c7-494f-8cc5-0203ef12ecf9, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:34,238 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 2239efb3-21c7-494f-8cc5-0203ef12ecf9, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:35,002 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:35,003 - INFO - __tests__.alter_compression.1714054  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_2_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1277728, 'BlobCount': 512}}
2025-11-21 12:09:35,004 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:35,004 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, dd335fe4-f2b8-474b-9d76-3aae72b430ec, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:35,005 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, dd335fe4-f2b8-474b-9d76-3aae72b430ec, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:35,010 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, dd335fe4-f2b8-474b-9d76-3aae72b430ec, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:36,412 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:36,413 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:36,413 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 8b28fce1-bdbb-452b-ab40-dd55a72d7aa8, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:36,414 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 8b28fce1-bdbb-452b-ab40-dd55a72d7aa8, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:36,416 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 8b28fce1-bdbb-452b-ab40-dd55a72d7aa8, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:37,086 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:37,087 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:37,088 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 1facc8cd-9368-4d1c-9106-294d290841e8, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:37,089 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 1facc8cd-9368-4d1c-9106-294d290841e8, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:37,091 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 1facc8cd-9368-4d1c-9106-294d290841e8, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:37,919 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:37,920 - INFO - __tests__.alter_compression.1714054  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_2_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1597184, 'BlobCount': 640}}
2025-11-21 12:09:37,921 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:37,921 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, a35da191-d7ca-4212-bed9-6de33eb3501d, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:37,922 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, a35da191-d7ca-4212-bed9-6de33eb3501d, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:37,924 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, a35da191-d7ca-4212-bed9-6de33eb3501d, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:39,583 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:39,584 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:39,585 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 45abe8a7-0e14-4b73-a819-fc479206b656, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:39,586 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 45abe8a7-0e14-4b73-a819-fc479206b656, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:39,588 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 45abe8a7-0e14-4b73-a819-fc479206b656, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:39,994 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:39,995 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:39,996 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 24b34409-d8b1-4e9e-82ce-25705a2e4fbb, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:39,997 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 24b34409-d8b1-4e9e-82ce-25705a2e4fbb, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:40,007 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 24b34409-d8b1-4e9e-82ce-25705a2e4fbb, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:40,888 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:40,889 - INFO - __tests__.alter_compression.1714054  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_2_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1916800, 'BlobCount': 768}}
2025-11-21 12:09:40,889 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:40,890 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 812d1ce0-0707-4b92-b4ae-b8b6f50922b7, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:40,891 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 812d1ce0-0707-4b92-b4ae-b8b6f50922b7, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:40,893 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 812d1ce0-0707-4b92-b4ae-b8b6f50922b7, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:42,284 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:42,285 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:42,285 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 420bb6e3-0370-4b8a-bc75-e8bec723997b, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:42,286 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 420bb6e3-0370-4b8a-bc75-e8bec723997b, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:42,288 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 420bb6e3-0370-4b8a-bc75-e8bec723997b, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:42,718 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:42,719 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:42,719 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, bdb37292-970f-4888-9fbd-817d7aa83f86, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:42,720 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, bdb37292-970f-4888-9fbd-817d7aa83f86, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:42,722 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, bdb37292-970f-4888-9fbd-817d7aa83f86, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:43,694 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:43,695 - INFO - __tests__.alter_compression.1714054  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_2_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2236496, 'BlobCount': 896}}
2025-11-21 12:09:43,696 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:43,696 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, dd82905a-2798-4878-b3a2-4fabc2adfd4c, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:43,697 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, dd82905a-2798-4878-b3a2-4fabc2adfd4c, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:43,704 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, dd82905a-2798-4878-b3a2-4fabc2adfd4c, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:45,246 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:45,247 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:45,247 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, ccd2ced2-9862-47c9-b709-c98760fc8a95, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:45,248 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, ccd2ced2-9862-47c9-b709-c98760fc8a95, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:45,250 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, ccd2ced2-9862-47c9-b709-c98760fc8a95, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:45,804 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:45,804 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:45,805 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 9e8d197b-abec-405e-902f-641791479131, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:45,806 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 9e8d197b-abec-405e-902f-641791479131, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:45,809 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 9e8d197b-abec-405e-902f-641791479131, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:47,101 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:47,102 - INFO - __tests__.alter_compression.1714054  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_2_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2556272, 'BlobCount': 1024}}
2025-11-21 12:09:47,102 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:47,103 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 45284345-a3ac-4228-9e3e-e3914934223a, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:47,104 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 45284345-a3ac-4228-9e3e-e3914934223a, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:47,112 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 45284345-a3ac-4228-9e3e-e3914934223a, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:49,009 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:49,010 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:49,011 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 2b5c3150-3bdd-4fc3-8e26-f275b6976d28, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:49,012 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 2b5c3150-3bdd-4fc3-8e26-f275b6976d28, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:49,013 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 2b5c3150-3bdd-4fc3-8e26-f275b6976d28, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:49,492 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:49,492 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:49,493 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 82670260-754f-4e5c-b5f5-3778b88091f5, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:49,494 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 82670260-754f-4e5c-b5f5-3778b88091f5, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:49,496 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 82670260-754f-4e5c-b5f5-3778b88091f5, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:50,367 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:50,368 - INFO - __tests__.alter_compression.1714054  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_2_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2875584, 'BlobCount': 1152}}
2025-11-21 12:09:50,368 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:50,369 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 10607129-5be4-4b3b-afca-e31947bec05f, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:50,370 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 10607129-5be4-4b3b-afca-e31947bec05f, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:50,375 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 10607129-5be4-4b3b-afca-e31947bec05f, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:52,552 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:52,553 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:52,554 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 1ba65ff9-cde2-4b1a-a055-7246a9fc27b5, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:52,555 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 1ba65ff9-cde2-4b1a-a055-7246a9fc27b5, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:52,572 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 1ba65ff9-cde2-4b1a-a055-7246a9fc27b5, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:53,132 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:53,133 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:53,134 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, d7e74569-3b85-4769-a6f9-8ba34bd6de64, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:53,135 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, d7e74569-3b85-4769-a6f9-8ba34bd6de64, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:53,137 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, d7e74569-3b85-4769-a6f9-8ba34bd6de64, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:54,374 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:54,375 - INFO - __tests__.alter_compression.1714054  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_2_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3195568, 'BlobCount': 1280}}
2025-11-21 12:09:54,376 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:54,376 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 776de78a-71d0-4bab-8454-b3f766a9f617, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:54,377 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 776de78a-71d0-4bab-8454-b3f766a9f617, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_2_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:54,379 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 776de78a-71d0-4bab-8454-b3f766a9f617, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:56,538 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:56,539 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:56,539 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 526614aa-49c3-4068-b932-948d23a9cfa1, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:56,540 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 526614aa-49c3-4068-b932-948d23a9cfa1, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:56,544 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 526614aa-49c3-4068-b932-948d23a9cfa1, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:57,389 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:57,390 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:57,391 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 39e0130e-82fb-4bf3-b7bb-1af2d56fc035, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:57,392 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 39e0130e-82fb-4bf3-b7bb-1af2d56fc035, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:57,393 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 39e0130e-82fb-4bf3-b7bb-1af2d56fc035, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:09:58,106 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:58,107 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:09:58,108 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, fb388cb1-d702-40c3-ac83-eef360e02bb6, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:09:58,108 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, fb388cb1-d702-40c3-ac83-eef360e02bb6, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_2_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:09:58,112 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, fb388cb1-d702-40c3-ac83-eef360e02bb6, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:03,265 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:10:13,327 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:10:13,327 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, a23c0699-009c-43e3-8040-98f85c8b15d4, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:10:13,328 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, a23c0699-009c-43e3-8040-98f85c8b15d4, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_2_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:13,330 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, a23c0699-009c-43e3-8040-98f85c8b15d4, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:19,265 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:10:19,339 - INFO - root.1714054  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_2_compression`, volumes `value` (8000000, 1597784)
2025-11-21 12:10:19,341 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:10:19,342 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 1a3212d4-0104-4e60-80d1-2d28b29c2105, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:10:19,343 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 1a3212d4-0104-4e60-80d1-2d28b29c2105, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" 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_2_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:19,344 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 1a3212d4-0104-4e60-80d1-2d28b29c2105, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:19,916 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:10:19,917 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:10:19,918 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 4c6ac6be-de75-4cec-8468-4a7bb17eb55a, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:10:19,919 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 4c6ac6be-de75-4cec-8468-4a7bb17eb55a, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_2_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:19,923 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 4c6ac6be-de75-4cec-8468-4a7bb17eb55a, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:23,972 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:10:34,003 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:10:34,004 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, d2fc6f79-0801-462d-abb1-74c4cad883f1, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:10:34,005 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, d2fc6f79-0801-462d-abb1-74c4cad883f1, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_2_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:34,007 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, d2fc6f79-0801-462d-abb1-74c4cad883f1, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:34,973 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:10:44,979 - DEBUG - ydb.query.pool.1714054  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:10:44,980 - DEBUG - ydb.connection.1714054  - _prepare_call: RpcState(ExecuteQuery, 6f63e28b-9b60-4e74-a62b-1095c601e6ab, ghrun-ts5cnd6jre.auto.internal:15670): creating call state
2025-11-21 12:10:44,981 - DEBUG - ydb.connection.1714054  - _log_request: RpcState(ExecuteQuery, 6f63e28b-9b60-4e74-a62b-1095c601e6ab, ghrun-ts5cnd6jre.auto.internal:15670): request = { session_id: "ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_2_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 12:10:44,983 - DEBUG - ydb.connection.1714054  - _log_response: RpcState(ExecuteQuery, 6f63e28b-9b60-4e74-a62b-1095c601e6ab, ghrun-ts5cnd6jre.auto.internal:15670): response = { <_MultiThreadedRendezvous object> }
2025-11-21 12:10:46,010 - DEBUG - ydb.query.pool.1714054  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzAzNGVmYTItOTRjNTAxYWYtOWQ0ZjM2ZTEtOGIxNjBkZGM=
2025-11-21 12:10:46,015 - INFO - root.1714054  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_2_compression`, volumes `value` (8000000, 1465320)
2025-11-21 12:10:46,028 - INFO - root.1714054  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_2_compression` 8092160 / 1465320: 5.522452433598122
2025-11-21 12:10:46,030 - INFO - ya.test.1714054  - pytest_runtest_teardown: Test teardown
