2025-10-16 17:15:55,187 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-16 17:15:55,187 - INFO - ya.test - pytest_runtest_setup: test_all_supported_compression[zstd_15_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 15]
2025-10-16 17:15:55,188 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-16 17:15:55,188 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-16 17:15:55,190 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-10-16 17:15:55,203 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-10-16 17:15:55,203 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/b9t0/00171c/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-16 17:15:55,205 - DEBUG - ya.test - execute: Command pid: 998979
2025-10-16 17:15:56,524 - DEBUG - ya.test - _save_outputs: Command (pid 998979) rc: 0
2025-10-16 17:15:56,525 - DEBUG - ya.test - _save_outputs: Command (pid 998979) elapsed time (sec): 1.3178908824920654
2025-10-16 17:15:56,525 - DEBUG - ya.test - _save_outputs: Command (pid 998979) idrss: 0
2025-10-16 17:15:56,526 - DEBUG - ya.test - _save_outputs: Command (pid 998979) inblock: 0
2025-10-16 17:15:56,526 - DEBUG - ya.test - _save_outputs: Command (pid 998979) isrss: 0
2025-10-16 17:15:56,526 - DEBUG - ya.test - _save_outputs: Command (pid 998979) ixrss: 0
2025-10-16 17:15:56,527 - DEBUG - ya.test - _save_outputs: Command (pid 998979) majflt: 0
2025-10-16 17:15:56,527 - DEBUG - ya.test - _save_outputs: Command (pid 998979) maxrss: 488332
2025-10-16 17:15:56,527 - DEBUG - ya.test - _save_outputs: Command (pid 998979) minflt: 45122
2025-10-16 17:15:56,528 - DEBUG - ya.test - _save_outputs: Command (pid 998979) msgrcv: 0
2025-10-16 17:15:56,528 - DEBUG - ya.test - _save_outputs: Command (pid 998979) msgsnd: 0
2025-10-16 17:15:56,529 - DEBUG - ya.test - _save_outputs: Command (pid 998979) nivcsw: 294
2025-10-16 17:15:56,529 - DEBUG - ya.test - _save_outputs: Command (pid 998979) nsignals: 0
2025-10-16 17:15:56,529 - DEBUG - ya.test - _save_outputs: Command (pid 998979) nswap: 0
2025-10-16 17:15:56,530 - DEBUG - ya.test - _save_outputs: Command (pid 998979) nvcsw: 14
2025-10-16 17:15:56,530 - DEBUG - ya.test - _save_outputs: Command (pid 998979) oublock: 8
2025-10-16 17:15:56,530 - DEBUG - ya.test - _save_outputs: Command (pid 998979) stime: 0.171461
2025-10-16 17:15:56,530 - DEBUG - ya.test - _save_outputs: Command (pid 998979) utime: 0.588201
2025-10-16 17:15:56,531 - DEBUG - ya.test - _save_outputs: Command (pid 998979) wtime: 1.32
2025-10-16 17:15:56,531 - DEBUG - ya.test - _save_outputs: Command (pid 998979) output:
Git info:
    Commit: d615d0ffd6e2f23c896ca96121aca842413fb672
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge 2f4fc663ace566d7ea72dd9c85ebd0092851e7e4 into 6819ac59eb1f43dd80b94010061f13b3ff17d91a

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-2kszfvc6cm
    Host information: 
        Linux ghrun-2kszfvc6cm 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/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/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-10-16 17:15:56,532 - DEBUG - ya.test - _save_outputs: Command (pid 998979) errors:

2025-10-16 17:15:56,532 - INFO - __tests__.base - _setup_ydb: Git info:
    Commit: d615d0ffd6e2f23c896ca96121aca842413fb672
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge 2f4fc663ace566d7ea72dd9c85ebd0092851e7e4 into 6819ac59eb1f43dd80b94010061f13b3ff17d91a

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-2kszfvc6cm
    Host information: 
        Linux ghrun-2kszfvc6cm 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/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/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-10-16 17:15:56,751 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/b9t0/00171c/ydb/apps/ydbd/ydbd
2025-10-16 17:15:56,753 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/28774
2025-10-16 17:15:56,755 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/b9t0/00171c/r3tmp/kikimr_cluster_rr73fvvt
2025-10-16 17:15:56,801 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/b9t0/00171c/ydb/apps/ydbd/ydbd
2025-10-16 17:15:56,802 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/13835
2025-10-16 17:15:56,802 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/1242
2025-10-16 17:15:56,803 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/27015
2025-10-16 17:15:56,803 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/26625
2025-10-16 17:15:56,805 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/b9t0/00171c/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_15_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.15/cluster/kikimr_configs"
2025-10-16 17:15:56,805 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/b9t0/00171c/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/b9t0/00171c/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_15_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.15/cluster/node_1/logfile_rplv9fe5.log --grpc-port=13835 --mon-port=1242 --ic-port=28774
2025-10-16 17:15:56,806 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:13835/1, disk_size 68719476736
2025-10-16 17:15:56,806 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/b9t0/00171c/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_15_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.15/cluster/kikimr_configs"
2025-10-16 17:15:56,806 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/b9t0/00171c/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/b9t0/00171c/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_15_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.15/cluster/node_1/logfile_rplv9fe5.log --grpc-port=13835 --mon-port=1242 --ic-port=28774
2025-10-16 17:15:56,808 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/b9t0/00171c/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/b9t0/00171c/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_15_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.15/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/b9t0/00171c/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_15_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.15/cluster/node_1/logfile_rplv9fe5.log', '--grpc-port=13835', '--mon-port=1242', '--ic-port=28774')' in '/home/runner/.ya/build/build_root/b9t0/00171c/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_15_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.15/cluster/node_1' (no wait)
2025-10-16 17:15:56,815 - DEBUG - ya.test - execute: Command pid: 999249
2025-10-16 17:15:56,816 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:13835/1
2025-10-16 17:15:56,817 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-10-16 17:15:56,818 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-10-16 17:15:56,819 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/b9t0/00171c/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-16 17:15:56,824 - DEBUG - ya.test - execute: Command pid: 999250
2025-10-16 17:15:57,973 - DEBUG - ya.test - _save_outputs: Command (pid 999250) rc: 0
2025-10-16 17:15:57,973 - DEBUG - ya.test - _save_outputs: Command (pid 999250) elapsed time (sec): 1.1474270820617676
2025-10-16 17:15:57,974 - DEBUG - ya.test - _save_outputs: Command (pid 999250) idrss: 0
2025-10-16 17:15:57,974 - DEBUG - ya.test - _save_outputs: Command (pid 999250) inblock: 0
2025-10-16 17:15:57,975 - DEBUG - ya.test - _save_outputs: Command (pid 999250) isrss: 0
2025-10-16 17:15:57,975 - DEBUG - ya.test - _save_outputs: Command (pid 999250) ixrss: 0
2025-10-16 17:15:57,975 - DEBUG - ya.test - _save_outputs: Command (pid 999250) majflt: 0
2025-10-16 17:15:57,975 - DEBUG - ya.test - _save_outputs: Command (pid 999250) maxrss: 491244
2025-10-16 17:15:57,976 - DEBUG - ya.test - _save_outputs: Command (pid 999250) minflt: 45162
2025-10-16 17:15:57,976 - DEBUG - ya.test - _save_outputs: Command (pid 999250) msgrcv: 0
2025-10-16 17:15:57,986 - DEBUG - ya.test - _save_outputs: Command (pid 999250) msgsnd: 0
2025-10-16 17:15:57,987 - DEBUG - ya.test - _save_outputs: Command (pid 999250) nivcsw: 233
2025-10-16 17:15:57,987 - DEBUG - ya.test - _save_outputs: Command (pid 999250) nsignals: 0
2025-10-16 17:15:57,987 - DEBUG - ya.test - _save_outputs: Command (pid 999250) nswap: 0
2025-10-16 17:15:57,987 - DEBUG - ya.test - _save_outputs: Command (pid 999250) nvcsw: 14
2025-10-16 17:15:57,988 - DEBUG - ya.test - _save_outputs: Command (pid 999250) oublock: 8
2025-10-16 17:15:57,988 - DEBUG - ya.test - _save_outputs: Command (pid 999250) stime: 0.24579199999999998
2025-10-16 17:15:57,988 - DEBUG - ya.test - _save_outputs: Command (pid 999250) utime: 0.499704
2025-10-16 17:15:57,989 - DEBUG - ya.test - _save_outputs: Command (pid 999250) wtime: 1.153
2025-10-16 17:15:57,989 - DEBUG - ya.test - _save_outputs: Command (pid 999250) output:
Git info:
    Commit: d615d0ffd6e2f23c896ca96121aca842413fb672
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge 2f4fc663ace566d7ea72dd9c85ebd0092851e7e4 into 6819ac59eb1f43dd80b94010061f13b3ff17d91a

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-2kszfvc6cm
    Host information: 
        Linux ghrun-2kszfvc6cm 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/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/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-10-16 17:15:57,989 - DEBUG - ya.test - _save_outputs: Command (pid 999250) errors:

2025-10-16 17:15:57,990 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: d615d0ffd6e2f23c896ca96121aca842413fb672
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge 2f4fc663ace566d7ea72dd9c85ebd0092851e7e4 into 6819ac59eb1f43dd80b94010061f13b3ff17d91a
2025-10-16 17:16:03,503 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/b9t0/00171c/ydb/apps/ydbd/ydbd
2025-10-16 17:16:03,504 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/b9t0/00171c/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:13835', '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: 28774\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-10-16 17:16:03,505 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-10-16 17:16:03,506 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-10-16 17:16:03,506 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/b9t0/00171c/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:13835', '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: 28774\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-10-16 17:16:03,528 - DEBUG - ya.test - execute: Command pid: 1000250
2025-10-16 17:16:04,745 - DEBUG - ya.test - _save_outputs: Command (pid 1000250) rc: 0
2025-10-16 17:16:04,745 - DEBUG - ya.test - _save_outputs: Command (pid 1000250) elapsed time (sec): 1.2151734828948975
2025-10-16 17:16:04,746 - DEBUG - ya.test - _save_outputs: Command (pid 1000250) idrss: 0
2025-10-16 17:16:04,746 - DEBUG - ya.test - _save_outputs: Command (pid 1000250) inblock: 0
2025-10-16 17:16:04,746 - DEBUG - ya.test - _save_outputs: Command (pid 1000250) isrss: 0
2025-10-16 17:16:04,746 - DEBUG - ya.test - _save_outputs: Command (pid 1000250) ixrss: 0
2025-10-16 17:16:04,747 - DEBUG - ya.test - _save_outputs: Command (pid 1000250) majflt: 0
2025-10-16 17:16:04,747 - DEBUG - ya.test - _save_outputs: Command (pid 1000250) maxrss: 584684
2025-10-16 17:16:04,747 - DEBUG - ya.test - _save_outputs: Command (pid 1000250) minflt: 51396
2025-10-16 17:16:04,747 - DEBUG - ya.test - _save_outputs: Command (pid 1000250) msgrcv: 0
2025-10-16 17:16:04,748 - DEBUG - ya.test - _save_outputs: Command (pid 1000250) msgsnd: 0
2025-10-16 17:16:04,748 - DEBUG - ya.test - _save_outputs: Command (pid 1000250) nivcsw: 235
2025-10-16 17:16:04,748 - DEBUG - ya.test - _save_outputs: Command (pid 1000250) nsignals: 0
2025-10-16 17:16:04,749 - DEBUG - ya.test - _save_outputs: Command (pid 1000250) nswap: 0
2025-10-16 17:16:04,749 - DEBUG - ya.test - _save_outputs: Command (pid 1000250) nvcsw: 680
2025-10-16 17:16:04,749 - DEBUG - ya.test - _save_outputs: Command (pid 1000250) oublock: 8
2025-10-16 17:16:04,750 - DEBUG - ya.test - _save_outputs: Command (pid 1000250) stime: 0.330407
2025-10-16 17:16:04,750 - DEBUG - ya.test - _save_outputs: Command (pid 1000250) utime: 0.5928209999999999
2025-10-16 17:16:04,750 - DEBUG - ya.test - _save_outputs: Command (pid 1000250) wtime: 1.238
2025-10-16 17:16:04,751 - DEBUG - ya.test - _save_outputs: Command (pid 1000250) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-10-16 17:16:04,751 - DEBUG - ya.test - _save_outputs: Command (pid 1000250) errors:

2025-10-16 17:16:04,760 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/b9t0/00171c/ydb/apps/ydbd/ydbd
2025-10-16 17:16:04,761 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/b9t0/00171c/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:13835', '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-10-16 17:16:04,763 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-10-16 17:16:04,763 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-10-16 17:16:04,764 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/b9t0/00171c/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:13835', '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-10-16 17:16:04,777 - DEBUG - ya.test - execute: Command pid: 1000765
2025-10-16 17:16:06,724 - DEBUG - ya.test - _save_outputs: Command (pid 1000765) rc: 0
2025-10-16 17:16:06,724 - DEBUG - ya.test - _save_outputs: Command (pid 1000765) elapsed time (sec): 1.9455339908599854
2025-10-16 17:16:06,725 - DEBUG - ya.test - _save_outputs: Command (pid 1000765) idrss: 0
2025-10-16 17:16:06,725 - DEBUG - ya.test - _save_outputs: Command (pid 1000765) inblock: 0
2025-10-16 17:16:06,725 - DEBUG - ya.test - _save_outputs: Command (pid 1000765) isrss: 0
2025-10-16 17:16:06,726 - DEBUG - ya.test - _save_outputs: Command (pid 1000765) ixrss: 0
2025-10-16 17:16:06,726 - DEBUG - ya.test - _save_outputs: Command (pid 1000765) majflt: 0
2025-10-16 17:16:06,726 - DEBUG - ya.test - _save_outputs: Command (pid 1000765) maxrss: 584808
2025-10-16 17:16:06,727 - DEBUG - ya.test - _save_outputs: Command (pid 1000765) minflt: 51384
2025-10-16 17:16:06,727 - DEBUG - ya.test - _save_outputs: Command (pid 1000765) msgrcv: 0
2025-10-16 17:16:06,727 - DEBUG - ya.test - _save_outputs: Command (pid 1000765) msgsnd: 0
2025-10-16 17:16:06,727 - DEBUG - ya.test - _save_outputs: Command (pid 1000765) nivcsw: 327
2025-10-16 17:16:06,729 - DEBUG - ya.test - _save_outputs: Command (pid 1000765) nsignals: 0
2025-10-16 17:16:06,729 - DEBUG - ya.test - _save_outputs: Command (pid 1000765) nswap: 0
2025-10-16 17:16:06,752 - DEBUG - ya.test - _save_outputs: Command (pid 1000765) nvcsw: 474
2025-10-16 17:16:06,752 - DEBUG - ya.test - _save_outputs: Command (pid 1000765) oublock: 8
2025-10-16 17:16:06,752 - DEBUG - ya.test - _save_outputs: Command (pid 1000765) stime: 0.274225
2025-10-16 17:16:06,753 - DEBUG - ya.test - _save_outputs: Command (pid 1000765) utime: 0.582073
2025-10-16 17:16:06,753 - DEBUG - ya.test - _save_outputs: Command (pid 1000765) wtime: 1.951
2025-10-16 17:16:06,753 - DEBUG - ya.test - _save_outputs: Command (pid 1000765) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-10-16 17:16:06,754 - DEBUG - ya.test - _save_outputs: Command (pid 1000765) errors:

2025-10-16 17:16:06,754 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-10-16 17:16:06,923 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-10-16 17:16:06,998 - DEBUG - ydb.connection - 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-10-16 17:16:07,007 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-16 17:16:07,008 - DEBUG - ydb.connection - 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-10-16 17:16:07,033 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-10-16 17:16:07,034 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 2fe62e74-589a-4ba0-91fc-c5cdfbc5296c, localhost:13835): creating call state
2025-10-16 17:16:07,035 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 2fe62e74-589a-4ba0-91fc-c5cdfbc5296c, localhost:13835): request = { database: "/Root" }
2025-10-16 17:16:07,057 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 2fe62e74-589a-4ba0-91fc-c5cdfbc5296c, localhost:13835): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-2kszfvc6cm.auto.internal" port: 13835 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-10-16 17:16:07,058 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-2kszfvc6cm.auto.internal:13835, location 1, ssl: False>]>
2025-10-16 17:16:07,059 - DEBUG - ydb.connection - 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-10-16 17:16:07,109 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:13835
2025-10-16 17:16:07,110 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-10-16 17:16:07,112 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 1a806856-555e-4a80-9611-1e70ae5cb986, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:07,112 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 1a806856-555e-4a80-9611-1e70ae5cb986, ghrun-2kszfvc6cm.auto.internal:13835): request = {  }
2025-10-16 17:16:07,121 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 1a806856-555e-4a80-9611-1e70ae5cb986, ghrun-2kszfvc6cm.auto.internal:13835): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" node_id: 1 }
2025-10-16 17:16:07,122 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, 770add57-b6cf-45d5-91cd-fc8073727ce0, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:07,122 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, 770add57-b6cf-45d5-91cd-fc8073727ce0, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" }
2025-10-16 17:16:07,153 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, 770add57-b6cf-45d5-91cd-fc8073727ce0, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:07,176 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:07,178 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5719ee2e-8edc-403a-83d3-0f9ac5ab422e, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:07,179 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5719ee2e-8edc-403a-83d3-0f9ac5ab422e, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:07,181 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5719ee2e-8edc-403a-83d3-0f9ac5ab422e, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:13,563 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:13,564 - INFO - __tests__.alter_compression - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-10-16 17:16:13,564 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:13,565 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c82fb047-cd40-4133-a3c1-40b8be20de90, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:13,566 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c82fb047-cd40-4133-a3c1-40b8be20de90, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:13,571 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c82fb047-cd40-4133-a3c1-40b8be20de90, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:15,468 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:15,469 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:15,469 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 77cbf14c-86a2-4864-af8b-e40539c4d7d0, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:15,470 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 77cbf14c-86a2-4864-af8b-e40539c4d7d0, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:15,472 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 77cbf14c-86a2-4864-af8b-e40539c4d7d0, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:17,243 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:17,243 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:17,244 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a198d20a-52cf-45d6-9918-e8c3886b3fa0, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:17,245 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a198d20a-52cf-45d6-9918-e8c3886b3fa0, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:17,246 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a198d20a-52cf-45d6-9918-e8c3886b3fa0, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:18,717 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:18,718 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:18,719 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, db95bb35-a16a-42c5-a8cf-c75a69a3da98, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:18,720 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, db95bb35-a16a-42c5-a8cf-c75a69a3da98, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:18,734 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, db95bb35-a16a-42c5-a8cf-c75a69a3da98, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:21,410 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:21,411 - INFO - __tests__.alter_compression - 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-10-16 17:16:21,411 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:21,412 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 834615e0-d04f-4d29-b3ba-e1ffe6d9bff9, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:21,413 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 834615e0-d04f-4d29-b3ba-e1ffe6d9bff9, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:21,414 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 834615e0-d04f-4d29-b3ba-e1ffe6d9bff9, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:23,094 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:23,095 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:23,095 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f659a21f-2ec8-4191-b83a-271012e78612, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:23,096 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f659a21f-2ec8-4191-b83a-271012e78612, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:23,098 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f659a21f-2ec8-4191-b83a-271012e78612, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:23,791 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:23,791 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:23,792 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ba509933-d005-4476-b37c-01be5bd6b42c, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:23,793 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ba509933-d005-4476-b37c-01be5bd6b42c, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:23,795 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ba509933-d005-4476-b37c-01be5bd6b42c, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:24,941 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:24,942 - INFO - __tests__.alter_compression - 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-10-16 17:16:24,942 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:24,943 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cadeb6f8-b0cc-42b5-aa57-e1b6a2cd65a9, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:24,950 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cadeb6f8-b0cc-42b5-aa57-e1b6a2cd65a9, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:24,951 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cadeb6f8-b0cc-42b5-aa57-e1b6a2cd65a9, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:26,923 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:26,923 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:26,924 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b9653227-9c49-43a9-9dcd-ce7bd473c90a, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:26,925 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b9653227-9c49-43a9-9dcd-ce7bd473c90a, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:26,927 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b9653227-9c49-43a9-9dcd-ce7bd473c90a, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:27,543 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:27,544 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:27,545 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3e5bffd6-dfd7-4cd8-824d-35c7785f555e, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:27,546 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3e5bffd6-dfd7-4cd8-824d-35c7785f555e, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:27,548 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3e5bffd6-dfd7-4cd8-824d-35c7785f555e, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:28,702 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:28,703 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 309178, 'Portions': 188}}, blobs: {'__DEFAULT': {'Portions': 182, 'BlobSize': 4858576, 'BlobCount': 384}}
2025-10-16 17:16:28,703 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:28,704 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7f0df2a7-e550-4883-92d1-7f84f3bab4fd, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:28,705 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7f0df2a7-e550-4883-92d1-7f84f3bab4fd, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:28,712 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7f0df2a7-e550-4883-92d1-7f84f3bab4fd, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:30,930 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:30,931 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:30,932 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5ad5d878-67eb-419a-a71e-75b4e4ee171b, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:30,933 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5ad5d878-67eb-419a-a71e-75b4e4ee171b, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:30,935 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5ad5d878-67eb-419a-a71e-75b4e4ee171b, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:31,298 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:31,298 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:31,299 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 94a3be13-7649-4b32-b55f-4561e585566b, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:31,300 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 94a3be13-7649-4b32-b55f-4561e585566b, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:31,301 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 94a3be13-7649-4b32-b55f-4561e585566b, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:32,161 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:32,162 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 238}}, blobs: {'__DEFAULT': {'Portions': 238, 'BlobSize': 6477648, 'BlobCount': 504}}
2025-10-16 17:16:32,162 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:32,163 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, be6e53d0-56c0-44c5-b3ed-838ac95be7e4, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:32,164 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, be6e53d0-56c0-44c5-b3ed-838ac95be7e4, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:32,170 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, be6e53d0-56c0-44c5-b3ed-838ac95be7e4, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:33,692 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:33,693 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:33,694 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 04bf8e30-b75c-44b1-af0c-7dbb3cd0f671, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:33,695 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 04bf8e30-b75c-44b1-af0c-7dbb3cd0f671, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:33,698 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 04bf8e30-b75c-44b1-af0c-7dbb3cd0f671, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:34,319 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:34,320 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:34,321 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7293101c-d0eb-49c2-b56f-300d22bad03c, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:34,322 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7293101c-d0eb-49c2-b56f-300d22bad03c, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:34,333 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7293101c-d0eb-49c2-b56f-300d22bad03c, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:35,443 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:35,444 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 299}}, blobs: {'__DEFAULT': {'Portions': 299, 'BlobSize': 8096072, 'BlobCount': 628}}
2025-10-16 17:16:35,444 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:35,445 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d7f18f12-b330-483b-9e03-c9673634c30f, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:35,446 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d7f18f12-b330-483b-9e03-c9673634c30f, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:35,457 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d7f18f12-b330-483b-9e03-c9673634c30f, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:37,522 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:37,523 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:37,524 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 45543fb7-9936-439f-8433-6879e623796b, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:37,525 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 45543fb7-9936-439f-8433-6879e623796b, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:37,533 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 45543fb7-9936-439f-8433-6879e623796b, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:37,860 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:37,861 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:37,862 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b352d10c-4dc4-4920-8a6e-268376ee8735, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:37,863 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b352d10c-4dc4-4920-8a6e-268376ee8735, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:37,867 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b352d10c-4dc4-4920-8a6e-268376ee8735, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:38,750 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:38,751 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 351}}, blobs: {'__DEFAULT': {'Portions': 351, 'BlobSize': 9713960, 'BlobCount': 738}}
2025-10-16 17:16:38,752 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:38,752 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d23aa6a0-4b2b-4351-b62f-b2d8123d246c, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:38,753 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d23aa6a0-4b2b-4351-b62f-b2d8123d246c, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:38,755 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d23aa6a0-4b2b-4351-b62f-b2d8123d246c, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:40,433 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:40,433 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:40,434 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 32071cef-c364-4c69-a221-53f9ec601661, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:40,435 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 32071cef-c364-4c69-a221-53f9ec601661, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:40,481 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 32071cef-c364-4c69-a221-53f9ec601661, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:41,020 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:41,021 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:41,022 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e9881782-d9cc-44bf-93ae-6d2c9e2b5d75, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:41,023 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e9881782-d9cc-44bf-93ae-6d2c9e2b5d75, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:41,033 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e9881782-d9cc-44bf-93ae-6d2c9e2b5d75, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:41,907 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:41,908 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 718630, 'Portions': 412}}, blobs: {'__DEFAULT': {'Portions': 390, 'BlobSize': 11330680, 'BlobCount': 826}}
2025-10-16 17:16:41,908 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:41,909 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 38c3511c-693b-4448-959a-a9b966ad9007, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:41,910 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 38c3511c-693b-4448-959a-a9b966ad9007, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:41,916 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 38c3511c-693b-4448-959a-a9b966ad9007, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:43,782 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:43,783 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:43,784 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 97ec9a5c-fc51-4746-9658-1232caa734ea, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:43,785 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 97ec9a5c-fc51-4746-9658-1232caa734ea, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:43,796 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 97ec9a5c-fc51-4746-9658-1232caa734ea, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:44,626 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:44,627 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:44,627 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 208ea77b-f101-40ca-8ba1-c523a2bb935d, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:44,628 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 208ea77b-f101-40ca-8ba1-c523a2bb935d, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:44,632 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 208ea77b-f101-40ca-8ba1-c523a2bb935d, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:45,597 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:45,597 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 821709, 'Portions': 450}}, blobs: {'__DEFAULT': {'Portions': 431, 'BlobSize': 13125056, 'BlobCount': 918}}
2025-10-16 17:16:45,598 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:45,599 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 28025b0a-480f-461e-bfa0-04fae196f8e7, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:45,600 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 28025b0a-480f-461e-bfa0-04fae196f8e7, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:45,601 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 28025b0a-480f-461e-bfa0-04fae196f8e7, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:47,184 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:47,185 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:47,186 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1bbafe62-4460-40fd-9842-4ac2d7fec91b, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:47,187 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1bbafe62-4460-40fd-9842-4ac2d7fec91b, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:47,189 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1bbafe62-4460-40fd-9842-4ac2d7fec91b, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:48,019 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:48,019 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:48,020 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8dd62395-d50f-43db-bd7a-833125bf99b8, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:48,021 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8dd62395-d50f-43db-bd7a-833125bf99b8, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:48,023 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8dd62395-d50f-43db-bd7a-833125bf99b8, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:49,458 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:49,459 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 937440, 'Portions': 477}}, blobs: {'__DEFAULT': {'Portions': 453, 'BlobSize': 14561560, 'BlobCount': 972}}
2025-10-16 17:16:49,459 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:49,460 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 08f583a0-7314-4a7e-9033-cf827f080a44, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:49,461 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 08f583a0-7314-4a7e-9033-cf827f080a44, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:49,478 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 08f583a0-7314-4a7e-9033-cf827f080a44, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:51,984 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:51,984 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:51,985 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0830860c-05e4-4ba6-90ea-9708786fc4f4, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:51,986 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0830860c-05e4-4ba6-90ea-9708786fc4f4, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:51,987 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0830860c-05e4-4ba6-90ea-9708786fc4f4, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:52,550 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:52,551 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:52,552 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 623a9ab3-8580-4d31-8023-e5f9968876d8, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:52,553 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 623a9ab3-8580-4d31-8023-e5f9968876d8, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:52,555 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 623a9ab3-8580-4d31-8023-e5f9968876d8, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:53,474 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:53,475 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 1014036, 'Portions': 510}}, blobs: {'__DEFAULT': {'Portions': 493, 'BlobSize': 16177424, 'BlobCount': 1058}}
2025-10-16 17:16:53,475 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:53,476 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, bde45159-e652-4dd8-9a16-048673424a5e, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:53,476 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, bde45159-e652-4dd8-9a16-048673424a5e, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:53,480 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, bde45159-e652-4dd8-9a16-048673424a5e, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:55,396 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:55,397 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:55,398 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cff8c1c4-c4bb-4cde-b24b-7aba48c20274, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:55,399 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cff8c1c4-c4bb-4cde-b24b-7aba48c20274, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:55,409 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cff8c1c4-c4bb-4cde-b24b-7aba48c20274, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:55,860 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:55,861 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:55,862 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e11048fb-637c-4619-9347-f234862050cc, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:55,863 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e11048fb-637c-4619-9347-f234862050cc, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:55,865 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e11048fb-637c-4619-9347-f234862050cc, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:16:56,369 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:56,370 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:16:56,371 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6db5bff1-a62e-4944-aaf1-ea96f465e8fa, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:16:56,372 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6db5bff1-a62e-4944-aaf1-ea96f465e8fa, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:16:56,374 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6db5bff1-a62e-4944-aaf1-ea96f465e8fa, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:17:02,832 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:17:12,879 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:17:12,880 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 69e16c77-1bbd-4eb2-a8f0-9b6bcfc0c64c, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:17:12,881 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 69e16c77-1bbd-4eb2-a8f0-9b6bcfc0c64c, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:17:12,882 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 69e16c77-1bbd-4eb2-a8f0-9b6bcfc0c64c, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:17:17,596 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:17:27,628 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:17:27,629 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8ab3cb19-5c07-4eed-863b-f6fd9305f869, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:17:27,631 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8ab3cb19-5c07-4eed-863b-f6fd9305f869, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:17:27,637 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8ab3cb19-5c07-4eed-863b-f6fd9305f869, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:17:29,778 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:17:39,794 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:17:39,796 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 036c907d-0592-4279-a911-1b42844f48bf, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:17:39,797 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 036c907d-0592-4279-a911-1b42844f48bf, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:17:39,798 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 036c907d-0592-4279-a911-1b42844f48bf, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:17:41,575 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:17:41,589 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8034704)
2025-10-16 17:17:41,590 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:17:41,591 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 57664871-c74b-4e6c-b74c-327aca22617c, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:17:41,591 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 57664871-c74b-4e6c-b74c-327aca22617c, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:17:41,593 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 57664871-c74b-4e6c-b74c-327aca22617c, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:17:43,306 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:17:53,329 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:17:53,330 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 91fd1808-ee49-46ff-8a6c-60241bbec756, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:17:53,330 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 91fd1808-ee49-46ff-8a6c-60241bbec756, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:17:53,332 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 91fd1808-ee49-46ff-8a6c-60241bbec756, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:17:54,899 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:17:54,917 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8034704)
2025-10-16 17:17:54,917 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:17:54,918 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e410dd5a-e428-41bf-802d-4b86d13525ab, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:17:54,919 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e410dd5a-e428-41bf-802d-4b86d13525ab, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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-10-16 17:17:54,922 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e410dd5a-e428-41bf-802d-4b86d13525ab, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:17:55,420 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:17:55,424 - INFO - ya.test - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_15_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 15])
2025-10-16 17:17:55,425 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:17:55,426 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b59c53c0-a5f5-4a5f-a7ee-a680e422d446, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:17:55,428 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b59c53c0-a5f5-4a5f-a7ee-a680e422d446, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_15_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 15)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-10-16 17:17:55,429 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b59c53c0-a5f5-4a5f-a7ee-a680e422d446, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:17:56,585 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-16 17:17:56,585 - DEBUG - ydb.connection - 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-10-16 17:17:56,609 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-10-16 17:17:56,610 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, a4429aa0-a5e5-47fe-959b-502837e81275, localhost:13835): creating call state
2025-10-16 17:17:56,610 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, a4429aa0-a5e5-47fe-959b-502837e81275, localhost:13835): request = { database: "/Root" }
2025-10-16 17:17:59,049 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, a4429aa0-a5e5-47fe-959b-502837e81275, localhost:13835): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-2kszfvc6cm.auto.internal" port: 13835 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-10-16 17:17:59,050 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-2kszfvc6cm.auto.internal:13835, location 1, ssl: False>]>
2025-10-16 17:17:59,051 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:13835
2025-10-16 17:17:59,780 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:17:59,781 - INFO - __tests__.alter_compression - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_15_compression created
2025-10-16 17:17:59,782 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:17:59,783 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ca4ede0d-51ee-4235-aadc-ad14116c3ae0, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:17:59,784 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ca4ede0d-51ee-4235-aadc-ad14116c3ae0, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_15_compression`" } stats_mode: STATS_MODE_NONE }
2025-10-16 17:17:59,791 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ca4ede0d-51ee-4235-aadc-ad14116c3ae0, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:00,817 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:00,818 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:00,819 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0cdb36ce-ef89-4e14-97f5-a6a2a96a5bfb, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:00,820 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0cdb36ce-ef89-4e14-97f5-a6a2a96a5bfb, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:00,825 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0cdb36ce-ef89-4e14-97f5-a6a2a96a5bfb, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:04,250 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:04,251 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:04,252 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1058ae1a-c3b3-46e7-9714-8252e01fc406, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:04,253 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1058ae1a-c3b3-46e7-9714-8252e01fc406, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:04,254 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1058ae1a-c3b3-46e7-9714-8252e01fc406, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:05,642 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:05,643 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:05,644 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7d1412ee-dd4a-4ac6-befe-c8c0b39acddb, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:05,645 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7d1412ee-dd4a-4ac6-befe-c8c0b39acddb, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:05,647 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7d1412ee-dd4a-4ac6-befe-c8c0b39acddb, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:07,615 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:07,616 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318544, 'BlobCount': 128}}
2025-10-16 17:18:07,617 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:07,618 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 31e346ba-9a5d-4af5-b18c-8b8ac860a44f, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:07,619 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 31e346ba-9a5d-4af5-b18c-8b8ac860a44f, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:07,622 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 31e346ba-9a5d-4af5-b18c-8b8ac860a44f, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:11,344 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:11,345 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:11,346 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d75b4b35-15bc-42a0-b2e7-1b2a7d86549b, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:11,347 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d75b4b35-15bc-42a0-b2e7-1b2a7d86549b, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:11,349 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d75b4b35-15bc-42a0-b2e7-1b2a7d86549b, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:11,667 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:11,668 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:11,669 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 943ec7a7-4c78-46d6-9e71-bbefc7699465, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:11,670 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 943ec7a7-4c78-46d6-9e71-bbefc7699465, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:11,672 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 943ec7a7-4c78-46d6-9e71-bbefc7699465, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:12,042 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:12,043 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 638064, 'BlobCount': 256}}
2025-10-16 17:18:12,043 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:12,044 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 82c27617-0790-42fd-98b3-9894aa835193, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:12,045 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 82c27617-0790-42fd-98b3-9894aa835193, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:12,047 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 82c27617-0790-42fd-98b3-9894aa835193, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:15,544 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:15,545 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:15,546 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c14028d5-8637-4b42-92f4-b8148bd60554, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:15,547 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c14028d5-8637-4b42-92f4-b8148bd60554, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:15,561 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c14028d5-8637-4b42-92f4-b8148bd60554, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:16,243 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:16,244 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:16,245 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, dfeacc7b-01a4-4c13-9267-967359fc4edd, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:16,246 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, dfeacc7b-01a4-4c13-9267-967359fc4edd, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:16,251 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, dfeacc7b-01a4-4c13-9267-967359fc4edd, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:17,018 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:17,019 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 957088, 'BlobCount': 384}}
2025-10-16 17:18:17,020 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:17,020 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5f94508c-0bcb-45dd-b6a5-705d4da29749, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:17,022 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5f94508c-0bcb-45dd-b6a5-705d4da29749, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:17,024 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5f94508c-0bcb-45dd-b6a5-705d4da29749, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:20,944 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:20,945 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:20,946 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fe50f896-18b9-4c48-bd41-eb8055b0c1fb, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:20,947 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fe50f896-18b9-4c48-bd41-eb8055b0c1fb, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:20,961 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fe50f896-18b9-4c48-bd41-eb8055b0c1fb, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:21,309 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:21,310 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:21,311 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d7cc4a09-7cbf-470d-ae46-33faad9b076c, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:21,312 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d7cc4a09-7cbf-470d-ae46-33faad9b076c, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:21,318 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d7cc4a09-7cbf-470d-ae46-33faad9b076c, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:21,819 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:21,820 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 239}}, blobs: {'__DEFAULT': {'Portions': 239, 'BlobSize': 1300720, 'BlobCount': 506}}
2025-10-16 17:18:21,820 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:21,821 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9943591e-41ce-4c5e-8d76-8950a9d4dda6, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:21,822 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9943591e-41ce-4c5e-8d76-8950a9d4dda6, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:21,824 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9943591e-41ce-4c5e-8d76-8950a9d4dda6, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:24,998 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:24,999 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:25,000 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3cde8730-a974-4223-97d4-4bbc60326193, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:25,001 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3cde8730-a974-4223-97d4-4bbc60326193, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:25,009 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3cde8730-a974-4223-97d4-4bbc60326193, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:25,485 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:25,486 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:25,487 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1e7abbcf-3956-4c08-a94a-9bcb85597851, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:25,488 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1e7abbcf-3956-4c08-a94a-9bcb85597851, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:25,490 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1e7abbcf-3956-4c08-a94a-9bcb85597851, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:26,489 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:26,490 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 294}}, blobs: {'__DEFAULT': {'Portions': 294, 'BlobSize': 1627176, 'BlobCount': 622}}
2025-10-16 17:18:26,491 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:26,491 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8e300acb-c87c-4240-a7f1-1b5d773d3b99, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:26,493 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8e300acb-c87c-4240-a7f1-1b5d773d3b99, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:26,496 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8e300acb-c87c-4240-a7f1-1b5d773d3b99, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:30,196 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:30,197 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:30,198 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5db90640-f4dc-415c-8fce-45bf343d36a3, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:30,199 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5db90640-f4dc-415c-8fce-45bf343d36a3, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:30,201 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5db90640-f4dc-415c-8fce-45bf343d36a3, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:30,629 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:30,630 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:30,630 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2e881f5a-a5c8-4418-95fc-d8f7a2d0eda4, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:30,631 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2e881f5a-a5c8-4418-95fc-d8f7a2d0eda4, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:30,633 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2e881f5a-a5c8-4418-95fc-d8f7a2d0eda4, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:31,265 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:31,266 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 322}}, blobs: {'__DEFAULT': {'Portions': 322, 'BlobSize': 1982872, 'BlobCount': 696}}
2025-10-16 17:18:31,266 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:31,267 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e48fe920-1b65-4724-b76e-a7e31c2e8881, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:31,269 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e48fe920-1b65-4724-b76e-a7e31c2e8881, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:31,270 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e48fe920-1b65-4724-b76e-a7e31c2e8881, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:34,673 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:34,673 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:34,674 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c2668040-a9ff-4f16-be2f-02c29bf6d9c9, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:34,675 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c2668040-a9ff-4f16-be2f-02c29bf6d9c9, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:34,677 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c2668040-a9ff-4f16-be2f-02c29bf6d9c9, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:35,217 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:35,218 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:35,219 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 19192da4-95de-49ae-b6ad-b1e6b3935406, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:35,220 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 19192da4-95de-49ae-b6ad-b1e6b3935406, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:35,221 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 19192da4-95de-49ae-b6ad-b1e6b3935406, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:36,243 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:36,244 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 709309, 'Portions': 377}}, blobs: {'__DEFAULT': {'Portions': 371, 'BlobSize': 2312144, 'BlobCount': 800}}
2025-10-16 17:18:36,244 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:36,245 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 36a225b9-5131-4843-adb3-1b0250e0b3e2, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:36,247 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 36a225b9-5131-4843-adb3-1b0250e0b3e2, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:36,257 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 36a225b9-5131-4843-adb3-1b0250e0b3e2, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:39,719 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:39,720 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:39,720 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f2bd2d87-99b0-4b64-aa1e-411972ba722d, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:39,721 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f2bd2d87-99b0-4b64-aa1e-411972ba722d, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:39,723 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f2bd2d87-99b0-4b64-aa1e-411972ba722d, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:40,048 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:40,049 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:40,050 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9e4520e0-0f50-4013-b8ab-0525d1e2e313, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:40,051 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9e4520e0-0f50-4013-b8ab-0525d1e2e313, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:40,054 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9e4520e0-0f50-4013-b8ab-0525d1e2e313, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:40,810 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:40,810 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 405}}, blobs: {'__DEFAULT': {'Portions': 405, 'BlobSize': 2651360, 'BlobCount': 878}}
2025-10-16 17:18:40,811 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:40,812 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 25de66c3-6ad3-42f6-9ad0-db537fd01c53, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:40,815 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 25de66c3-6ad3-42f6-9ad0-db537fd01c53, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:40,817 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 25de66c3-6ad3-42f6-9ad0-db537fd01c53, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:44,636 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:44,637 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:44,638 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8353d1de-757b-4f23-b957-f6701baffd42, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:44,638 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8353d1de-757b-4f23-b957-f6701baffd42, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:44,640 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8353d1de-757b-4f23-b957-f6701baffd42, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:45,210 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:45,211 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:45,212 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 28e21ddd-7500-4ee8-8f08-ee66d3467831, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:45,213 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 28e21ddd-7500-4ee8-8f08-ee66d3467831, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:45,214 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 28e21ddd-7500-4ee8-8f08-ee66d3467831, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:46,609 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:46,627 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2995192, 'BlobCount': 970}}
2025-10-16 17:18:46,628 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:46,632 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1d87acdb-4415-49f8-bdbd-64e964346fc3, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:46,633 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1d87acdb-4415-49f8-bdbd-64e964346fc3, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:46,635 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1d87acdb-4415-49f8-bdbd-64e964346fc3, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:50,128 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:50,128 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:50,129 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9f380496-0996-46bd-8258-fd67f3a958d8, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:50,131 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9f380496-0996-46bd-8258-fd67f3a958d8, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:50,132 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9f380496-0996-46bd-8258-fd67f3a958d8, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:50,650 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:50,651 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:50,652 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0cf5841d-2b7a-4760-bb76-71dae07d57b7, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:50,653 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0cf5841d-2b7a-4760-bb76-71dae07d57b7, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:50,654 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0cf5841d-2b7a-4760-bb76-71dae07d57b7, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:51,543 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:51,543 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 1014128, 'Portions': 465}}, blobs: {'__DEFAULT': {'Portions': 457, 'BlobSize': 3432808, 'BlobCount': 1004}}
2025-10-16 17:18:51,544 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:51,545 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 85b13c5f-8f9f-4ed8-811f-32f2a85bb550, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:51,545 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 85b13c5f-8f9f-4ed8-811f-32f2a85bb550, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_15_compression`" } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:51,548 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 85b13c5f-8f9f-4ed8-811f-32f2a85bb550, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:52,788 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:52,789 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:52,790 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c75041e8-71be-43c7-ae0e-9c653f8a369e, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:52,791 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c75041e8-71be-43c7-ae0e-9c653f8a369e, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:52,793 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c75041e8-71be-43c7-ae0e-9c653f8a369e, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:53,131 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:53,132 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:53,133 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ff8ae23f-278b-41c4-b952-fe812ad45c55, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:53,134 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ff8ae23f-278b-41c4-b952-fe812ad45c55, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:53,135 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ff8ae23f-278b-41c4-b952-fe812ad45c55, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:53,489 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:53,490 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:18:53,491 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f6edc90c-8c03-4ac3-8cb2-237a1082a7ca, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:18:53,491 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f6edc90c-8c03-4ac3-8cb2-237a1082a7ca, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-10-16 17:18:53,492 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f6edc90c-8c03-4ac3-8cb2-237a1082a7ca, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:18:58,089 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:19:08,116 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:19:08,122 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, baa5ba4d-f277-4c5a-8682-c304f25df4cc, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:19:08,123 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, baa5ba4d-f277-4c5a-8682-c304f25df4cc, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-10-16 17:19:08,125 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, baa5ba4d-f277-4c5a-8682-c304f25df4cc, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:19:10,933 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:19:10,950 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_15_compression`, volumes `value` (8000000, 1752880)
2025-10-16 17:19:10,962 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:19:10,963 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5721c8ba-2d62-4c15-9889-f625baee1e51, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:19:10,963 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5721c8ba-2d62-4c15-9889-f625baee1e51, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" 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_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-16 17:19:10,966 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5721c8ba-2d62-4c15-9889-f625baee1e51, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:19:11,445 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:19:11,446 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:19:11,447 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 89cfd53d-396d-4784-b4a0-4206baf0a1e7, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:19:11,448 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 89cfd53d-396d-4784-b4a0-4206baf0a1e7, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-10-16 17:19:11,450 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 89cfd53d-396d-4784-b4a0-4206baf0a1e7, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:19:14,153 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:19:24,188 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:19:24,189 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ef8679d5-182c-4440-8b2d-f0b52147924f, ghrun-2kszfvc6cm.auto.internal:13835): creating call state
2025-10-16 17:19:24,190 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ef8679d5-182c-4440-8b2d-f0b52147924f, ghrun-2kszfvc6cm.auto.internal:13835): request = { session_id: "ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-10-16 17:19:24,191 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ef8679d5-182c-4440-8b2d-f0b52147924f, ghrun-2kszfvc6cm.auto.internal:13835): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:19:26,063 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-16 17:19:26,064 - DEBUG - ydb.connection - 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-10-16 17:19:26,091 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-10-16 17:19:26,091 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 58ddb9ae-77f3-4c02-9f1b-2d5795d595ad, localhost:13835): creating call state
2025-10-16 17:19:26,092 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 58ddb9ae-77f3-4c02-9f1b-2d5795d595ad, localhost:13835): request = { database: "/Root" }
2025-10-16 17:19:26,106 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 58ddb9ae-77f3-4c02-9f1b-2d5795d595ad, localhost:13835): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-2kszfvc6cm.auto.internal" port: 13835 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-10-16 17:19:26,107 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-2kszfvc6cm.auto.internal:13835, location 1, ssl: False>]>
2025-10-16 17:19:26,107 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:13835
2025-10-16 17:19:27,194 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWQzOGJhODUtMzYxZjZlN2MtOTU4ZGFiMGUtY2VlNTkxNGI=
2025-10-16 17:19:27,220 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_15_compression`, volumes `value` (8000000, 1752880)
2025-10-16 17:19:27,221 - INFO - root - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_15_compression` 8034704 / 1752880: 4.58371594176441
2025-10-16 17:19:27,224 - INFO - ya.test - pytest_runtest_teardown: Test teardown
