2025-12-23 19:01:15,790 - INFO - ya.test.1657981  - pytest_runtest_setup: ####################################################################################################
2025-12-23 19:01:15,791 - INFO - ya.test.1657981  - pytest_runtest_setup: test_all_supported_compression[zstd_15_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 15]
2025-12-23 19:01:15,791 - INFO - ya.test.1657981  - pytest_runtest_setup: ####################################################################################################
2025-12-23 19:01:15,791 - INFO - ya.test.1657981  - pytest_runtest_setup: Test setup
2025-12-23 19:01:15,794 - DEBUG - ya.test.1657981  - _get_command_output_file: Command out will be placed to ydbd.out
2025-12-23 19:01:15,794 - DEBUG - ya.test.1657981  - _get_command_output_file: Command err will be placed to ydbd.err
2025-12-23 19:01:15,795 - DEBUG - ya.test.1657981  - execute: Executing '['/home/runner/.ya/build/build_root/8ptz/0046b4/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-23 19:01:15,819 - DEBUG - ya.test.1657981  - execute: Command pid: 1660631
2025-12-23 19:01:17,480 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1660631) rc: 0
2025-12-23 19:01:17,480 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1660631) elapsed time (sec): 1.659522533416748
2025-12-23 19:01:17,481 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1660631) idrss: 0
2025-12-23 19:01:17,481 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1660631) inblock: 0
2025-12-23 19:01:17,481 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1660631) isrss: 0
2025-12-23 19:01:17,481 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1660631) ixrss: 0
2025-12-23 19:01:17,482 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1660631) majflt: 0
2025-12-23 19:01:17,482 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1660631) maxrss: 483696
2025-12-23 19:01:17,482 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1660631) minflt: 45776
2025-12-23 19:01:17,483 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1660631) msgrcv: 0
2025-12-23 19:01:17,483 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1660631) msgsnd: 0
2025-12-23 19:01:17,483 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1660631) nivcsw: 240
2025-12-23 19:01:17,484 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1660631) nsignals: 0
2025-12-23 19:01:17,484 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1660631) nswap: 0
2025-12-23 19:01:17,484 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1660631) nvcsw: 15
2025-12-23 19:01:17,484 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1660631) oublock: 8
2025-12-23 19:01:17,485 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1660631) stime: 0.245665
2025-12-23 19:01:17,485 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1660631) utime: 0.569967
2025-12-23 19:01:17,485 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1660631) wtime: 1.684
2025-12-23 19:01:17,486 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1660631) output:
Git info:
    Commit: 09729cc9cf0669d9f027468138c7d2dc45a65d8c
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge ff1b65d8e0d4692b69b059de261ca6f72c94cd74 into 7a46c6293674d1de550a9922546b7e0022176cfa
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-ou4bsyjxme    Host information: 
        Linux ghrun-ou4bsyjxme 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

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

2025-12-23 19:01:17,487 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1660631) errors:

2025-12-23 19:01:17,487 - INFO - __tests__.base.1657981  - _setup_ydb: Git info:
    Commit: 09729cc9cf0669d9f027468138c7d2dc45a65d8c
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge ff1b65d8e0d4692b69b059de261ca6f72c94cd74 into 7a46c6293674d1de550a9922546b7e0022176cfa
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-ou4bsyjxme    Host information: 
        Linux ghrun-ou4bsyjxme 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

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

2025-12-23 19:01:17,653 - DEBUG - ya.test.1657981  - get_binary: Binary was found by /home/runner/.ya/build/build_root/8ptz/0046b4/ydb/apps/ydbd/ydbd
2025-12-23 19:01:17,655 - DEBUG - library.python.filelock.1657981  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/28369
2025-12-23 19:01:17,657 - DEBUG - ydb.tests.library.harness.kikimr_runner.1657981  - start: Working directory: /home/runner/.ya/build/build_root/8ptz/0046b4/r3tmp/kikimr_cluster_gp1u4uk5
2025-12-23 19:01:17,731 - DEBUG - ya.test.1657981  - get_binary: Binary was found by /home/runner/.ya/build/build_root/8ptz/0046b4/ydb/apps/ydbd/ydbd
2025-12-23 19:01:17,732 - DEBUG - library.python.filelock.1657981  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/20617
2025-12-23 19:01:17,732 - DEBUG - library.python.filelock.1657981  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/21776
2025-12-23 19:01:17,733 - DEBUG - library.python.filelock.1657981  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/27851
2025-12-23 19:01:17,734 - DEBUG - library.python.filelock.1657981  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/4901
2025-12-23 19:01:17,735 - INFO - ydb.tests.library.harness.kikimr_runner.1657981  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/8ptz/0046b4/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-12-23 19:01:17,736 - INFO - ydb.tests.library.harness.kikimr_runner.1657981  - __make_run_command: Final command: /home/runner/.ya/build/build_root/8ptz/0046b4/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/8ptz/0046b4/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_6temvtbw.log --grpc-port=20617 --mon-port=21776 --ic-port=28369
2025-12-23 19:01:17,736 - DEBUG - ydb.tests.library.harness.kikimr_runner.1657981  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:20617/1, disk_size 68719476736
2025-12-23 19:01:17,737 - INFO - ydb.tests.library.harness.kikimr_runner.1657981  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/8ptz/0046b4/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-12-23 19:01:17,737 - INFO - ydb.tests.library.harness.kikimr_runner.1657981  - __make_run_command: Final command: /home/runner/.ya/build/build_root/8ptz/0046b4/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/8ptz/0046b4/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_6temvtbw.log --grpc-port=20617 --mon-port=21776 --ic-port=28369
2025-12-23 19:01:17,740 - DEBUG - ya.test.1657981  - execute: Executing '('/home/runner/.ya/build/build_root/8ptz/0046b4/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/8ptz/0046b4/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/8ptz/0046b4/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_6temvtbw.log', '--grpc-port=20617', '--mon-port=21776', '--ic-port=28369')' in '/home/runner/.ya/build/build_root/8ptz/0046b4/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-12-23 19:01:17,751 - DEBUG - ya.test.1657981  - execute: Command pid: 1661219
2025-12-23 19:01:17,753 - INFO - ydb.tests.library.harness.kikimr_runner.1657981  - start: Started node localhost:20617/1
2025-12-23 19:01:17,755 - DEBUG - ya.test.1657981  - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-12-23 19:01:17,755 - DEBUG - ya.test.1657981  - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-12-23 19:01:17,756 - DEBUG - ya.test.1657981  - execute: Executing '['/home/runner/.ya/build/build_root/8ptz/0046b4/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-23 19:01:17,765 - DEBUG - ya.test.1657981  - execute: Command pid: 1661220
2025-12-23 19:01:19,619 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1661220) rc: 0
2025-12-23 19:01:19,619 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1661220) elapsed time (sec): 1.852205514907837
2025-12-23 19:01:19,620 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1661220) idrss: 0
2025-12-23 19:01:19,620 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1661220) inblock: 0
2025-12-23 19:01:19,620 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1661220) isrss: 0
2025-12-23 19:01:19,621 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1661220) ixrss: 0
2025-12-23 19:01:19,621 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1661220) majflt: 0
2025-12-23 19:01:19,621 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1661220) maxrss: 488772
2025-12-23 19:01:19,622 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1661220) minflt: 45864
2025-12-23 19:01:19,622 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1661220) msgrcv: 0
2025-12-23 19:01:19,622 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1661220) msgsnd: 0
2025-12-23 19:01:19,623 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1661220) nivcsw: 220
2025-12-23 19:01:19,623 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1661220) nsignals: 0
2025-12-23 19:01:19,629 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1661220) nswap: 0
2025-12-23 19:01:19,630 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1661220) nvcsw: 14
2025-12-23 19:01:19,630 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1661220) oublock: 8
2025-12-23 19:01:19,631 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1661220) stime: 0.224662
2025-12-23 19:01:19,631 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1661220) utime: 0.5504439999999999
2025-12-23 19:01:19,631 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1661220) wtime: 1.862
2025-12-23 19:01:19,632 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1661220) output:
Git info:
    Commit: 09729cc9cf0669d9f027468138c7d2dc45a65d8c
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge ff1b65d8e0d4692b69b059de261ca6f72c94cd74 into 7a46c6293674d1de550a9922546b7e0022176cfa
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-ou4bsyjxme    Host information: 
        Linux ghrun-ou4bsyjxme 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

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

2025-12-23 19:01:19,632 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1661220) errors:

2025-12-23 19:01:19,633 - INFO - ydb.tests.library.harness.kikimr_runner.1657981  - start: Node 1 version:
Git info:
    Commit: 09729cc9cf0669d9f027468138c7d2dc45a65d8c
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge ff1b65d8e0d4692b69b059de261ca6f72c94cd74 into 7a46c6293674d1de550a9922546b7e0022176cfa
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-ou4bsyjxme    Host information: 
        Linux ghrun-ou4bsyjxme 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64
2025-12-23 19:01:28,323 - DEBUG - ya.test.1657981  - get_binary: Binary was found by /home/runner/.ya/build/build_root/8ptz/0046b4/ydb/apps/ydbd/ydbd
2025-12-23 19:01:28,324 - DEBUG - ydb.tests.library.harness.kikimr_runner.1657981  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/8ptz/0046b4/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:20617', '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: 28369\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-12-23 19:01:28,325 - DEBUG - ya.test.1657981  - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-12-23 19:01:28,326 - DEBUG - ya.test.1657981  - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-12-23 19:01:28,327 - DEBUG - ya.test.1657981  - execute: Executing '['/home/runner/.ya/build/build_root/8ptz/0046b4/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:20617', '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: 28369\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-12-23 19:01:28,347 - DEBUG - ya.test.1657981  - execute: Command pid: 1663406
2025-12-23 19:01:29,784 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663406) rc: 0
2025-12-23 19:01:29,784 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663406) elapsed time (sec): 1.4358563423156738
2025-12-23 19:01:29,785 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663406) idrss: 0
2025-12-23 19:01:29,785 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663406) inblock: 0
2025-12-23 19:01:29,785 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663406) isrss: 0
2025-12-23 19:01:29,786 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663406) ixrss: 0
2025-12-23 19:01:29,786 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663406) majflt: 0
2025-12-23 19:01:29,786 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663406) maxrss: 596704
2025-12-23 19:01:29,786 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663406) minflt: 52305
2025-12-23 19:01:29,787 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663406) msgrcv: 0
2025-12-23 19:01:29,787 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663406) msgsnd: 0
2025-12-23 19:01:29,787 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663406) nivcsw: 396
2025-12-23 19:01:29,788 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663406) nsignals: 0
2025-12-23 19:01:29,788 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663406) nswap: 0
2025-12-23 19:01:29,788 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663406) nvcsw: 472
2025-12-23 19:01:29,788 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663406) oublock: 8
2025-12-23 19:01:29,789 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663406) stime: 0.323951
2025-12-23 19:01:29,789 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663406) utime: 0.576858
2025-12-23 19:01:29,789 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663406) wtime: 1.456
2025-12-23 19:01:29,790 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663406) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-12-23 19:01:29,790 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663406) errors:

2025-12-23 19:01:29,828 - DEBUG - ya.test.1657981  - get_binary: Binary was found by /home/runner/.ya/build/build_root/8ptz/0046b4/ydb/apps/ydbd/ydbd
2025-12-23 19:01:29,828 - DEBUG - ydb.tests.library.harness.kikimr_runner.1657981  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/8ptz/0046b4/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:20617', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']
2025-12-23 19:01:29,829 - DEBUG - ya.test.1657981  - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-12-23 19:01:29,830 - DEBUG - ya.test.1657981  - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-12-23 19:01:29,830 - DEBUG - ya.test.1657981  - execute: Executing '['/home/runner/.ya/build/build_root/8ptz/0046b4/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:20617', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']' in 'None' (waiting)
2025-12-23 19:01:29,832 - DEBUG - ya.test.1657981  - execute: Command pid: 1663592
2025-12-23 19:01:31,051 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663592) rc: 0
2025-12-23 19:01:31,051 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663592) elapsed time (sec): 1.2185959815979004
2025-12-23 19:01:31,052 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663592) idrss: 0
2025-12-23 19:01:31,052 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663592) inblock: 0
2025-12-23 19:01:31,052 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663592) isrss: 0
2025-12-23 19:01:31,053 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663592) ixrss: 0
2025-12-23 19:01:31,053 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663592) majflt: 0
2025-12-23 19:01:31,053 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663592) maxrss: 597528
2025-12-23 19:01:31,053 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663592) minflt: 52154
2025-12-23 19:01:31,054 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663592) msgrcv: 0
2025-12-23 19:01:31,054 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663592) msgsnd: 0
2025-12-23 19:01:31,054 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663592) nivcsw: 187
2025-12-23 19:01:31,054 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663592) nsignals: 0
2025-12-23 19:01:31,055 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663592) nswap: 0
2025-12-23 19:01:31,055 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663592) nvcsw: 510
2025-12-23 19:01:31,056 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663592) oublock: 8
2025-12-23 19:01:31,056 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663592) stime: 0.25082
2025-12-23 19:01:31,056 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663592) utime: 0.591635
2025-12-23 19:01:31,056 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663592) wtime: 1.22
2025-12-23 19:01:31,057 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663592) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-12-23 19:01:31,057 - DEBUG - ya.test.1657981  - _save_outputs: Command (pid 1663592) errors:

2025-12-23 19:01:31,057 - INFO - ydb.tests.library.harness.kikimr_runner.1657981  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-12-23 19:01:31,236 - INFO - ydb.tests.library.harness.kikimr_runner.1657981  - __run: Cluster started and initialized
2025-12-23 19:01:31,330 - DEBUG - ydb.connection.1657981  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 19:01:31,333 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1657981  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-23 19:01:31,334 - DEBUG - ydb.connection.1657981  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 19:01:31,378 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1657981  - context_resolve: Resolving endpoints for database /Root
2025-12-23 19:01:31,379 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ListEndpoints, 6e6b3192-f9ac-4b56-86ed-bfe2755c49f2, localhost:20617): creating call state
2025-12-23 19:01:31,380 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ListEndpoints, 6e6b3192-f9ac-4b56-86ed-bfe2755c49f2, localhost:20617): request = { database: "/Root" }
2025-12-23 19:01:31,429 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ListEndpoints, 6e6b3192-f9ac-4b56-86ed-bfe2755c49f2, localhost:20617): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-ou4bsyjxme.auto.internal" port: 20617 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-12-23 19:01:31,429 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1657981  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-ou4bsyjxme.auto.internal:20617, location 1, ssl: False>]>
2025-12-23 19:01:31,430 - DEBUG - ydb.connection.1657981  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 19:01:31,462 - DEBUG - ydb.connection.1657981  - close: Closing channel for endpoint localhost:20617
2025-12-23 19:01:31,463 - DEBUG - ydb.query.pool.1657981  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-23 19:01:31,465 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(CreateSession, 3619afb7-340d-448b-885c-7044b144fab1, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:01:31,466 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(CreateSession, 3619afb7-340d-448b-885c-7044b144fab1, ghrun-ou4bsyjxme.auto.internal:20617): request = {  }
2025-12-23 19:01:31,476 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(CreateSession, 3619afb7-340d-448b-885c-7044b144fab1, ghrun-ou4bsyjxme.auto.internal:20617): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" node_id: 1 }
2025-12-23 19:01:31,477 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(AttachSession, 29a61635-7b14-4dc6-9952-a63a3bb9e47b, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:01:31,478 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(AttachSession, 29a61635-7b14-4dc6-9952-a63a3bb9e47b, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" }
2025-12-23 19:01:31,484 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(AttachSession, 29a61635-7b14-4dc6-9952-a63a3bb9e47b, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:31,494 - DEBUG - ydb.query.pool.1657981  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:31,495 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, bafd5ff0-abe9-437d-a1f3-c1442d297cd7, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:01:31,496 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, bafd5ff0-abe9-437d-a1f3-c1442d297cd7, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/off_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"off\")\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:01:31,498 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, bafd5ff0-abe9-437d-a1f3-c1442d297cd7, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:35,184 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:35,185 - INFO - __tests__.alter_compression.1657981  - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-12-23 19:01:35,186 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:35,187 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, e1679b08-5a18-47ba-bf8e-520b3733b581, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:01:35,188 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, e1679b08-5a18-47ba-bf8e-520b3733b581, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/off_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:01:35,189 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, e1679b08-5a18-47ba-bf8e-520b3733b581, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:36,317 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:36,317 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:36,318 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 1c4b517c-7e89-4750-870c-59772e7f87a3, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:01:36,318 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 1c4b517c-7e89-4750-870c-59772e7f87a3, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 0;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:01:36,320 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 1c4b517c-7e89-4750-870c-59772e7f87a3, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:37,725 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:37,727 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:37,728 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 280d3f13-e144-4e67-bffe-bf0d9df4d742, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:01:37,729 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 280d3f13-e144-4e67-bffe-bf0d9df4d742, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:01:37,730 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 280d3f13-e144-4e67-bffe-bf0d9df4d742, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:38,903 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:38,904 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:38,905 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 92ebf19c-a61a-4401-b1ae-952c9558eea8, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:01:38,906 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 92ebf19c-a61a-4401-b1ae-952c9558eea8, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:01:38,907 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 92ebf19c-a61a-4401-b1ae-952c9558eea8, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:41,326 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:41,327 - INFO - __tests__.alter_compression.1657981  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 1618432, 'BlobCount': 128}}
2025-12-23 19:01:41,328 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:41,328 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, e2a6675a-af27-4c4d-812d-d16a37690574, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:01:41,329 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, e2a6675a-af27-4c4d-812d-d16a37690574, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 100000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:01:41,337 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, e2a6675a-af27-4c4d-812d-d16a37690574, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:42,812 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:42,812 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:42,813 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, cd520009-1859-4b51-889a-089c71112746, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:01:42,813 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, cd520009-1859-4b51-889a-089c71112746, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:01:42,815 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, cd520009-1859-4b51-889a-089c71112746, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:43,250 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:43,251 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:43,251 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 716eb072-ac3e-453b-baf4-902026eaf634, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:01:43,252 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 716eb072-ac3e-453b-baf4-902026eaf634, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:01:43,256 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 716eb072-ac3e-453b-baf4-902026eaf634, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:44,042 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:44,043 - INFO - __tests__.alter_compression.1657981  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 3236864, 'BlobCount': 256}}
2025-12-23 19:01:44,043 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:44,044 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, ba4c8125-17b5-40c8-ba96-1600aa248fa2, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:01:44,045 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, ba4c8125-17b5-40c8-ba96-1600aa248fa2, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 200000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:01:44,056 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, ba4c8125-17b5-40c8-ba96-1600aa248fa2, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:45,603 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:45,604 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:45,604 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 4012eb8a-af11-4699-9704-608b52d5771c, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:01:45,605 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 4012eb8a-af11-4699-9704-608b52d5771c, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:01:45,607 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 4012eb8a-af11-4699-9704-608b52d5771c, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:46,584 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:46,585 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:46,586 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 2290dd5e-39c3-4269-9ec0-6cb475ba0e0b, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:01:46,588 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 2290dd5e-39c3-4269-9ec0-6cb475ba0e0b, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:01:46,589 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 2290dd5e-39c3-4269-9ec0-6cb475ba0e0b, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:47,418 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:47,419 - INFO - __tests__.alter_compression.1657981  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 4855296, 'BlobCount': 384}}
2025-12-23 19:01:47,420 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:47,421 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, d83edb49-8f31-4dee-8cd9-b96fad55e239, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:01:47,422 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, d83edb49-8f31-4dee-8cd9-b96fad55e239, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 300000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:01:47,425 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, d83edb49-8f31-4dee-8cd9-b96fad55e239, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:49,071 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:49,072 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:49,073 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 08f5af74-4ba0-4857-9c51-30d4b600483d, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:01:49,074 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 08f5af74-4ba0-4857-9c51-30d4b600483d, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:01:49,087 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 08f5af74-4ba0-4857-9c51-30d4b600483d, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:49,695 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:49,696 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:49,697 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 41c2ebd2-7092-4022-9062-0c790f3e13a1, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:01:49,698 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 41c2ebd2-7092-4022-9062-0c790f3e13a1, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:01:49,700 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 41c2ebd2-7092-4022-9062-0c790f3e13a1, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:50,434 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:50,434 - INFO - __tests__.alter_compression.1657981  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 6473728, 'BlobCount': 512}}
2025-12-23 19:01:50,435 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:50,435 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, e210882b-4a29-4415-b164-f48fc7522e0c, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:01:50,436 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, e210882b-4a29-4415-b164-f48fc7522e0c, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 400000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:01:50,439 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, e210882b-4a29-4415-b164-f48fc7522e0c, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:52,161 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:52,162 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:52,163 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 30d4d2be-178a-46e7-8e4d-768958ea126c, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:01:52,163 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 30d4d2be-178a-46e7-8e4d-768958ea126c, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:01:52,165 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 30d4d2be-178a-46e7-8e4d-768958ea126c, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:52,905 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:52,906 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:52,907 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 0dbb023f-7bad-4813-9169-fedcff91698d, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:01:52,908 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 0dbb023f-7bad-4813-9169-fedcff91698d, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:01:52,912 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 0dbb023f-7bad-4813-9169-fedcff91698d, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:53,689 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:53,690 - INFO - __tests__.alter_compression.1657981  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 8092160, 'BlobCount': 640}}
2025-12-23 19:01:53,690 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:53,691 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, e55e390c-ce3b-4db8-80ac-32d8e506c1c6, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:01:53,692 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, e55e390c-ce3b-4db8-80ac-32d8e506c1c6, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 500000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:01:53,707 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, e55e390c-ce3b-4db8-80ac-32d8e506c1c6, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:55,284 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:55,285 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:55,286 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 4b60915d-2dbc-4fdf-9c31-74e3aaac97c9, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:01:55,287 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 4b60915d-2dbc-4fdf-9c31-74e3aaac97c9, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:01:55,288 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 4b60915d-2dbc-4fdf-9c31-74e3aaac97c9, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:55,840 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:55,841 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:55,841 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 0b516396-3661-4a74-87ed-361f75245461, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:01:55,843 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 0b516396-3661-4a74-87ed-361f75245461, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:01:55,844 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 0b516396-3661-4a74-87ed-361f75245461, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:57,492 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:57,493 - INFO - __tests__.alter_compression.1657981  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 9710592, 'BlobCount': 768}}
2025-12-23 19:01:57,493 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:57,494 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 28baa78d-628a-4ab4-bc48-25bcdff3bfce, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:01:57,496 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 28baa78d-628a-4ab4-bc48-25bcdff3bfce, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 600000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:01:57,497 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 28baa78d-628a-4ab4-bc48-25bcdff3bfce, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:59,151 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:59,152 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:59,153 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 6af7c962-4639-4774-8ed5-845433e8f149, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:01:59,154 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 6af7c962-4639-4774-8ed5-845433e8f149, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:01:59,156 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 6af7c962-4639-4774-8ed5-845433e8f149, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:01:59,684 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:59,685 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:01:59,685 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 9876a3a0-5411-4764-ae8d-07ae7fb9bb97, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:01:59,686 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 9876a3a0-5411-4764-ae8d-07ae7fb9bb97, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:01:59,688 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 9876a3a0-5411-4764-ae8d-07ae7fb9bb97, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:00,727 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:00,728 - INFO - __tests__.alter_compression.1657981  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 11329024, 'BlobCount': 896}}
2025-12-23 19:02:00,728 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:00,729 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, df0c2055-abc3-49f9-b83b-cb5c472e05b6, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:02:00,730 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, df0c2055-abc3-49f9-b83b-cb5c472e05b6, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 700000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:02:00,733 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, df0c2055-abc3-49f9-b83b-cb5c472e05b6, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:02,220 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:02,221 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:02,221 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, b304ec57-311d-4b93-8b2d-d1d3746777de, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:02:02,222 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, b304ec57-311d-4b93-8b2d-d1d3746777de, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:02:02,223 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, b304ec57-311d-4b93-8b2d-d1d3746777de, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:02,597 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:02,598 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:02,599 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, e68b9e69-003a-4bcc-a58e-0faa3de06834, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:02:02,600 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, e68b9e69-003a-4bcc-a58e-0faa3de06834, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:02:02,602 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, e68b9e69-003a-4bcc-a58e-0faa3de06834, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:03,723 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:03,723 - INFO - __tests__.alter_compression.1657981  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 12947456, 'BlobCount': 1024}}
2025-12-23 19:02:03,724 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:03,724 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, a190b35d-b3e9-48e1-a265-7b0f988380e8, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:02:03,725 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, a190b35d-b3e9-48e1-a265-7b0f988380e8, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 800000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:02:03,730 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, a190b35d-b3e9-48e1-a265-7b0f988380e8, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:05,427 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:05,428 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:05,428 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, b1401230-31d6-4b61-824c-063fcb302b90, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:02:05,429 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, b1401230-31d6-4b61-824c-063fcb302b90, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:02:05,432 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, b1401230-31d6-4b61-824c-063fcb302b90, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:05,912 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:05,913 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:05,914 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, c97d56cc-5905-4915-a243-6889b48a3e65, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:02:05,915 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, c97d56cc-5905-4915-a243-6889b48a3e65, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:02:05,931 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, c97d56cc-5905-4915-a243-6889b48a3e65, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:07,394 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:07,395 - INFO - __tests__.alter_compression.1657981  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 14565888, 'BlobCount': 1152}}
2025-12-23 19:02:07,395 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:07,396 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 5a08b7c7-5de7-4892-86fc-ba118686f31e, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:02:07,397 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 5a08b7c7-5de7-4892-86fc-ba118686f31e, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 900000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:02:07,398 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 5a08b7c7-5de7-4892-86fc-ba118686f31e, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:09,373 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:09,373 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:09,374 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, d9cba95a-67b2-4901-ab62-034fcab73092, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:02:09,378 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, d9cba95a-67b2-4901-ab62-034fcab73092, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:02:09,380 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, d9cba95a-67b2-4901-ab62-034fcab73092, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:09,842 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:09,842 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:09,843 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 949c6665-95a9-4ed4-901c-2e865975d994, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:02:09,844 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 949c6665-95a9-4ed4-901c-2e865975d994, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:02:09,845 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 949c6665-95a9-4ed4-901c-2e865975d994, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:10,807 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:10,808 - INFO - __tests__.alter_compression.1657981  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 16184320, 'BlobCount': 1280}}
2025-12-23 19:02:10,808 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:10,809 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 30ad8d1a-5379-4ce7-918f-b54e5446ad01, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:02:10,810 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 30ad8d1a-5379-4ce7-918f-b54e5446ad01, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/off_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:02:10,812 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 30ad8d1a-5379-4ce7-918f-b54e5446ad01, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:13,514 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:13,514 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:13,515 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, efcb751e-8c6b-4740-9d0a-65a79e9bd087, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:02:13,516 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, efcb751e-8c6b-4740-9d0a-65a79e9bd087, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:02:13,517 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, efcb751e-8c6b-4740-9d0a-65a79e9bd087, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:14,009 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:14,010 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:14,011 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 0136c820-3fcb-41a1-bb09-a1e00d267a23, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:02:14,012 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 0136c820-3fcb-41a1-bb09-a1e00d267a23, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:02:14,013 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 0136c820-3fcb-41a1-bb09-a1e00d267a23, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:14,658 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:14,658 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:14,659 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, a64491ed-8053-4f40-a890-f5989b0034a4, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:02:14,660 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, a64491ed-8053-4f40-a890-f5989b0034a4, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:02:14,661 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, a64491ed-8053-4f40-a890-f5989b0034a4, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:22,944 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:33,018 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:33,019 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 61ab0263-255a-4cbd-a8c5-9d7e9e03f430, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:02:33,020 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 61ab0263-255a-4cbd-a8c5-9d7e9e03f430, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:02:33,021 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 61ab0263-255a-4cbd-a8c5-9d7e9e03f430, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:35,863 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1657981  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-23 19:02:35,864 - DEBUG - ydb.connection.1657981  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 19:02:35,878 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1657981  - context_resolve: Resolving endpoints for database /Root
2025-12-23 19:02:35,879 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ListEndpoints, 018e3e20-3df9-47b4-b904-1c43fa7b7c65, localhost:20617): creating call state
2025-12-23 19:02:35,879 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ListEndpoints, 018e3e20-3df9-47b4-b904-1c43fa7b7c65, localhost:20617): request = { database: "/Root" }
2025-12-23 19:02:35,988 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ListEndpoints, 018e3e20-3df9-47b4-b904-1c43fa7b7c65, localhost:20617): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-ou4bsyjxme.auto.internal" port: 20617 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-12-23 19:02:35,990 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1657981  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-ou4bsyjxme.auto.internal:20617, location 1, ssl: False>]>
2025-12-23 19:02:35,995 - DEBUG - ydb.connection.1657981  - close: Closing channel for endpoint localhost:20617
2025-12-23 19:02:39,400 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:49,469 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:02:49,470 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, a2e126ce-8110-4b5a-9ca7-c8dd22f868be, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:02:49,470 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, a2e126ce-8110-4b5a-9ca7-c8dd22f868be, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:02:49,472 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, a2e126ce-8110-4b5a-9ca7-c8dd22f868be, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:02:50,709 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:00,715 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:00,716 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, fb8e2a4f-c5cb-4e19-a7d6-812016f596d3, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:00,717 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, fb8e2a4f-c5cb-4e19-a7d6-812016f596d3, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:00,718 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, fb8e2a4f-c5cb-4e19-a7d6-812016f596d3, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:01,497 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:01,501 - INFO - root.1657981  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8009216)
2025-12-23 19:03:01,502 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:01,503 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, c8e764a0-c63a-4891-a6c4-999d02549366, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:01,504 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, c8e764a0-c63a-4891-a6c4-999d02549366, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:01,506 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, c8e764a0-c63a-4891-a6c4-999d02549366, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:02,534 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:12,538 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:12,539 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, fd7e55f8-3acb-48ad-9aee-afe44b76ec76, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:12,541 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, fd7e55f8-3acb-48ad-9aee-afe44b76ec76, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:12,542 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, fd7e55f8-3acb-48ad-9aee-afe44b76ec76, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:13,765 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:13,770 - INFO - root.1657981  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8009216)
2025-12-23 19:03:13,787 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:13,788 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 610c5856-4f3d-4041-b2e2-3c51aeac591c, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:13,789 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 610c5856-4f3d-4041-b2e2-3c51aeac591c, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:13,801 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 610c5856-4f3d-4041-b2e2-3c51aeac591c, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:14,216 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:14,225 - INFO - ya.test.1657981  - 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-12-23 19:03:14,226 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:14,227 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, b62bcedc-cc62-4b2b-a3f1-74ae57500536, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:14,231 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, b62bcedc-cc62-4b2b-a3f1-74ae57500536, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:14,233 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, b62bcedc-cc62-4b2b-a3f1-74ae57500536, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:17,772 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:17,772 - INFO - __tests__.alter_compression.1657981  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_15_compression created
2025-12-23 19:03:17,773 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:17,774 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, f736d2ee-33dc-4fc9-9b3e-123259535dd5, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:17,775 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, f736d2ee-33dc-4fc9-9b3e-123259535dd5, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:17,782 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, f736d2ee-33dc-4fc9-9b3e-123259535dd5, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:18,713 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:18,714 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:18,715 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 0983d0d5-2213-49c5-83bb-d427b5d47bc1, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:18,716 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 0983d0d5-2213-49c5-83bb-d427b5d47bc1, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:18,717 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 0983d0d5-2213-49c5-83bb-d427b5d47bc1, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:22,599 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:22,600 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:22,600 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 6404ba7f-065e-417b-8a51-c278ba4f2c3f, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:22,601 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 6404ba7f-065e-417b-8a51-c278ba4f2c3f, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:22,603 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 6404ba7f-065e-417b-8a51-c278ba4f2c3f, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:23,865 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:23,865 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:23,866 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, e068693e-6f94-41a0-a543-ca49c7723417, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:23,867 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, e068693e-6f94-41a0-a543-ca49c7723417, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:23,868 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, e068693e-6f94-41a0-a543-ca49c7723417, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:26,339 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:26,340 - INFO - __tests__.alter_compression.1657981  - 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-12-23 19:03:26,341 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:26,341 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 492feae1-6ec2-4448-8f0a-56edb9618176, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:26,342 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 492feae1-6ec2-4448-8f0a-56edb9618176, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:26,344 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 492feae1-6ec2-4448-8f0a-56edb9618176, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:29,836 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:29,836 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:29,837 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, a5235c4d-fdff-4108-850c-fe2406e928b3, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:29,838 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, a5235c4d-fdff-4108-850c-fe2406e928b3, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:29,839 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, a5235c4d-fdff-4108-850c-fe2406e928b3, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:30,164 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:30,165 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:30,166 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 2e6f1587-5017-4061-b57d-59fcdac85e8e, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:30,171 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 2e6f1587-5017-4061-b57d-59fcdac85e8e, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:30,173 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 2e6f1587-5017-4061-b57d-59fcdac85e8e, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:30,598 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:30,599 - INFO - __tests__.alter_compression.1657981  - 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-12-23 19:03:30,600 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:30,600 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, b1a37c93-fb3f-4833-a88a-c9066d1c5fdb, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:30,601 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, b1a37c93-fb3f-4833-a88a-c9066d1c5fdb, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:30,603 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, b1a37c93-fb3f-4833-a88a-c9066d1c5fdb, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:34,655 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:34,655 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:34,656 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, a3764b5d-9737-4201-abb3-7d70c7570d4a, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:34,657 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, a3764b5d-9737-4201-abb3-7d70c7570d4a, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:34,658 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, a3764b5d-9737-4201-abb3-7d70c7570d4a, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:34,962 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:34,963 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:34,964 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, c65f5e7f-766e-4508-821f-c898a9cb13f8, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:34,965 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, c65f5e7f-766e-4508-821f-c898a9cb13f8, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:34,966 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, c65f5e7f-766e-4508-821f-c898a9cb13f8, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:35,414 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:35,415 - INFO - __tests__.alter_compression.1657981  - 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-12-23 19:03:35,415 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:35,416 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 057f79a4-2149-4f92-b079-20954ea7311b, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:35,417 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 057f79a4-2149-4f92-b079-20954ea7311b, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:35,420 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 057f79a4-2149-4f92-b079-20954ea7311b, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:38,813 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:38,813 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:38,814 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, b2b9b800-d50e-4682-b4df-3e4c9200f3d6, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:38,815 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, b2b9b800-d50e-4682-b4df-3e4c9200f3d6, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:38,816 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, b2b9b800-d50e-4682-b4df-3e4c9200f3d6, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:39,165 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:39,166 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:39,166 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, fa72230d-3faa-4b30-9244-06ae9b18d97a, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:39,167 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, fa72230d-3faa-4b30-9244-06ae9b18d97a, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:39,169 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, fa72230d-3faa-4b30-9244-06ae9b18d97a, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:39,673 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:39,673 - INFO - __tests__.alter_compression.1657981  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1276560, 'BlobCount': 512}}
2025-12-23 19:03:39,674 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:39,674 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 08f12511-8cc7-4164-8ea4-cbd49e6df7a4, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:39,675 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 08f12511-8cc7-4164-8ea4-cbd49e6df7a4, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:39,676 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 08f12511-8cc7-4164-8ea4-cbd49e6df7a4, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:42,948 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:42,948 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:42,949 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, c837d49a-9368-4b89-b621-0e5158188519, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:42,950 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, c837d49a-9368-4b89-b621-0e5158188519, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:42,952 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, c837d49a-9368-4b89-b621-0e5158188519, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:43,412 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:43,413 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:43,413 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 27e46a55-1087-43f6-9e96-2b3ac3778951, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:43,414 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 27e46a55-1087-43f6-9e96-2b3ac3778951, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:43,420 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 27e46a55-1087-43f6-9e96-2b3ac3778951, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:44,160 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:44,161 - INFO - __tests__.alter_compression.1657981  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1595584, 'BlobCount': 640}}
2025-12-23 19:03:44,161 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:44,162 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 15613025-3388-494b-92f7-707c267d5628, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:44,163 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 15613025-3388-494b-92f7-707c267d5628, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:44,169 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 15613025-3388-494b-92f7-707c267d5628, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:48,093 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:48,094 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:48,095 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, d8db3881-ab2e-47c2-9814-9a02b4c8ccef, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:48,096 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, d8db3881-ab2e-47c2-9814-9a02b4c8ccef, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:48,100 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, d8db3881-ab2e-47c2-9814-9a02b4c8ccef, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:48,542 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:48,543 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:48,543 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 01e9acb4-312d-416c-a8e8-fd8ddbd3c662, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:48,550 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 01e9acb4-312d-416c-a8e8-fd8ddbd3c662, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:48,552 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 01e9acb4-312d-416c-a8e8-fd8ddbd3c662, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:49,352 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:49,352 - INFO - __tests__.alter_compression.1657981  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1914960, 'BlobCount': 768}}
2025-12-23 19:03:49,353 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:49,354 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, dd379173-881b-4a8c-96d9-cc3551dc4ccf, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:49,355 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, dd379173-881b-4a8c-96d9-cc3551dc4ccf, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:49,356 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, dd379173-881b-4a8c-96d9-cc3551dc4ccf, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:53,531 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:53,532 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:53,533 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, e0842d90-422c-496f-bf2d-3c8dfafa5d2a, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:53,533 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, e0842d90-422c-496f-bf2d-3c8dfafa5d2a, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:53,535 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, e0842d90-422c-496f-bf2d-3c8dfafa5d2a, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:53,994 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:53,997 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:53,998 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 03dbbbd1-d3aa-42c0-bba1-5f09545f8e8b, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:53,999 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 03dbbbd1-d3aa-42c0-bba1-5f09545f8e8b, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:54,001 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 03dbbbd1-d3aa-42c0-bba1-5f09545f8e8b, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:54,855 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:54,856 - INFO - __tests__.alter_compression.1657981  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2234080, 'BlobCount': 896}}
2025-12-23 19:03:54,856 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:54,857 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 8ccc7e8e-1a7c-46d1-95ab-233938b30de4, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:54,858 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 8ccc7e8e-1a7c-46d1-95ab-233938b30de4, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:54,859 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 8ccc7e8e-1a7c-46d1-95ab-233938b30de4, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:59,123 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:59,124 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:59,125 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, ce874c93-87fe-4bd8-93ef-1f2862229b46, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:59,130 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, ce874c93-87fe-4bd8-93ef-1f2862229b46, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:59,132 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, ce874c93-87fe-4bd8-93ef-1f2862229b46, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:03:59,681 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:59,681 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:03:59,682 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, e5ce4900-9e37-4cc5-91ce-15c3b8256c04, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:03:59,683 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, e5ce4900-9e37-4cc5-91ce-15c3b8256c04, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:03:59,686 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, e5ce4900-9e37-4cc5-91ce-15c3b8256c04, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:00,675 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:04:00,676 - INFO - __tests__.alter_compression.1657981  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2553696, 'BlobCount': 1024}}
2025-12-23 19:04:00,676 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:04:00,677 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, ee3ec2f6-c2f4-43fb-8789-e16d7a768294, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:04:00,678 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, ee3ec2f6-c2f4-43fb-8789-e16d7a768294, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:04:00,680 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, ee3ec2f6-c2f4-43fb-8789-e16d7a768294, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:05,039 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:04:05,039 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:04:05,040 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 5a7417c8-9639-4366-8318-e0ab45401d4b, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:04:05,041 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 5a7417c8-9639-4366-8318-e0ab45401d4b, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:04:05,047 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 5a7417c8-9639-4366-8318-e0ab45401d4b, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:05,522 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:04:05,523 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:04:05,524 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 5075e3af-177a-49ad-a214-8e7148866605, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:04:05,525 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 5075e3af-177a-49ad-a214-8e7148866605, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:04:05,530 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 5075e3af-177a-49ad-a214-8e7148866605, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:06,548 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:04:06,549 - INFO - __tests__.alter_compression.1657981  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2872720, 'BlobCount': 1152}}
2025-12-23 19:04:06,550 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:04:06,551 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 4d78515d-5f9f-4640-88c3-5fd82c2bc3e8, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:04:06,552 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 4d78515d-5f9f-4640-88c3-5fd82c2bc3e8, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:04:06,557 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 4d78515d-5f9f-4640-88c3-5fd82c2bc3e8, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:11,387 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:04:11,388 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:04:11,389 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 68743465-a761-414a-ba75-796b7bd46d38, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:04:11,390 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 68743465-a761-414a-ba75-796b7bd46d38, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:04:11,392 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 68743465-a761-414a-ba75-796b7bd46d38, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:12,032 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:04:12,033 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:04:12,034 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 789940c7-1249-48db-8e60-375d027f3d8a, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:04:12,035 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 789940c7-1249-48db-8e60-375d027f3d8a, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:04:12,037 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 789940c7-1249-48db-8e60-375d027f3d8a, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:13,078 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:04:13,078 - INFO - __tests__.alter_compression.1657981  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3192432, 'BlobCount': 1280}}
2025-12-23 19:04:13,079 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:04:13,080 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, b18b2a64-a6a1-40f0-b6ff-fb603868c0f6, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:04:13,081 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, b18b2a64-a6a1-40f0-b6ff-fb603868c0f6, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:04:13,084 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, b18b2a64-a6a1-40f0-b6ff-fb603868c0f6, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:14,479 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:04:14,480 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:04:14,481 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, ddbdaf0a-764e-4987-9031-b729ca661fea, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:04:14,482 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, ddbdaf0a-764e-4987-9031-b729ca661fea, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:04:14,484 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, ddbdaf0a-764e-4987-9031-b729ca661fea, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:14,824 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:04:14,826 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:04:14,826 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, f5c1a343-51aa-4faa-bf75-3baefe0990c1, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:04:14,828 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, f5c1a343-51aa-4faa-bf75-3baefe0990c1, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:04:14,829 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, f5c1a343-51aa-4faa-bf75-3baefe0990c1, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:15,168 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:04:15,168 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:04:15,169 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 92b923ba-a9f8-42cb-acee-b52ef59d4cd1, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:04:15,170 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 92b923ba-a9f8-42cb-acee-b52ef59d4cd1, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:04:15,171 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 92b923ba-a9f8-42cb-acee-b52ef59d4cd1, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:20,910 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:04:30,991 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:04:30,991 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, ade5656b-3b1d-41f4-a4cc-82ed940b7101, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:04:30,992 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, ade5656b-3b1d-41f4-a4cc-82ed940b7101, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:04:30,993 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, ade5656b-3b1d-41f4-a4cc-82ed940b7101, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:32,376 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1657981  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-23 19:04:32,377 - DEBUG - ydb.connection.1657981  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 19:04:32,402 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1657981  - context_resolve: Resolving endpoints for database /Root
2025-12-23 19:04:32,403 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ListEndpoints, c55faa49-fd5d-40dc-85f5-78e721c65f7e, localhost:20617): creating call state
2025-12-23 19:04:32,404 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ListEndpoints, c55faa49-fd5d-40dc-85f5-78e721c65f7e, localhost:20617): request = { database: "/Root" }
2025-12-23 19:04:32,685 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ListEndpoints, c55faa49-fd5d-40dc-85f5-78e721c65f7e, localhost:20617): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-ou4bsyjxme.auto.internal" port: 20617 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-12-23 19:04:32,686 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1657981  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-ou4bsyjxme.auto.internal:20617, location 1, ssl: False>]>
2025-12-23 19:04:32,686 - DEBUG - ydb.connection.1657981  - close: Closing channel for endpoint localhost:20617
2025-12-23 19:04:34,496 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:04:34,533 - INFO - root.1657981  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_15_compression`, volumes `value` (8000000, 1729264)
2025-12-23 19:04:34,534 - DEBUG - ydb.query.pool.1657981  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:04:34,539 - DEBUG - ydb.connection.1657981  - _prepare_call: RpcState(ExecuteQuery, 5ff2a3ef-a06b-455e-85fa-a37116f7b60e, ghrun-ou4bsyjxme.auto.internal:20617): creating call state
2025-12-23 19:04:34,540 - DEBUG - ydb.connection.1657981  - _log_request: RpcState(ExecuteQuery, 5ff2a3ef-a06b-455e-85fa-a37116f7b60e, ghrun-ou4bsyjxme.auto.internal:20617): request = { session_id: "ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 19:04:34,542 - DEBUG - ydb.connection.1657981  - _log_response: RpcState(ExecuteQuery, 5ff2a3ef-a06b-455e-85fa-a37116f7b60e, ghrun-ou4bsyjxme.auto.internal:20617): response = { <_MultiThreadedRendezvous object> }
2025-12-23 19:04:35,251 - DEBUG - ydb.query.pool.1657981  - release: Session returned to queue: ydb://session/3?node_id=1&id=ZDlmOTU1OTMtYWVhNGQyODAtYmZmMGJmMTYtNWU3N2NhZDU=
2025-12-23 19:04:36,274 - ERROR - ya.test.1657981  - logreport: ydb/tests/olap/column_family/compression/alter_compression.py:194: in test_all_supported_compression
    assert table.get_portion_stat_by_tier()['__DEFAULT']['Rows'] == expected_raw // 8
E   assert 1015704 == (8000000 // 8)
2025-12-23 19:04:36,277 - INFO - ya.test.1657981  - pytest_runtest_teardown: Test teardown
