2025-12-09 12:49:40,687 - INFO - ya.test.1986723  - pytest_runtest_setup: ####################################################################################################
2025-12-09 12:49:40,688 - INFO - ya.test.1986723  - pytest_runtest_setup: test_all_supported_compression[zstd_12_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 12]
2025-12-09 12:49:40,688 - INFO - ya.test.1986723  - pytest_runtest_setup: ####################################################################################################
2025-12-09 12:49:40,688 - INFO - ya.test.1986723  - pytest_runtest_setup: Test setup
2025-12-09 12:49:40,691 - DEBUG - ya.test.1986723  - _get_command_output_file: Command out will be placed to ydbd.out
2025-12-09 12:49:40,692 - DEBUG - ya.test.1986723  - _get_command_output_file: Command err will be placed to ydbd.err
2025-12-09 12:49:40,692 - DEBUG - ya.test.1986723  - execute: Executing '['/home/runner/.ya/build/build_root/cm7y/0043b2/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-09 12:49:40,698 - DEBUG - ya.test.1986723  - execute: Command pid: 1988016
2025-12-09 12:49:41,746 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988016) rc: 0
2025-12-09 12:49:41,747 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988016) elapsed time (sec): 1.0469636917114258
2025-12-09 12:49:41,747 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988016) idrss: 0
2025-12-09 12:49:41,747 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988016) inblock: 0
2025-12-09 12:49:41,747 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988016) isrss: 0
2025-12-09 12:49:41,748 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988016) ixrss: 0
2025-12-09 12:49:41,748 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988016) majflt: 0
2025-12-09 12:49:41,748 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988016) maxrss: 502608
2025-12-09 12:49:41,748 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988016) minflt: 45684
2025-12-09 12:49:41,749 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988016) msgrcv: 0
2025-12-09 12:49:41,749 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988016) msgsnd: 0
2025-12-09 12:49:41,749 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988016) nivcsw: 156
2025-12-09 12:49:41,749 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988016) nsignals: 0
2025-12-09 12:49:41,750 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988016) nswap: 0
2025-12-09 12:49:41,750 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988016) nvcsw: 14
2025-12-09 12:49:41,750 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988016) oublock: 8
2025-12-09 12:49:41,750 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988016) stime: 0.179471
2025-12-09 12:49:41,751 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988016) utime: 0.48911099999999996
2025-12-09 12:49:41,751 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988016) wtime: 1.053
2025-12-09 12:49:41,751 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988016) output:
Git info:
    Commit: ddb9b596fa394c4a7a03070d9031b3067b79c8d4
    Branch: 
    Author: Pisarenko Grigoriy <grigoriypisar@ydb.tech>
    Summary: Merge 79a09f7950d025ac7651c8845c6ab578953fef41 into cd0aab03f9646e0cb890d748a31ed35e4e9d9963
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-7wapoxkjru    Host information: 
        Linux ghrun-7wapoxkjru 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-09 12:49:41,752 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988016) errors:

2025-12-09 12:49:41,752 - INFO - __tests__.base.1986723  - _setup_ydb: Git info:
    Commit: ddb9b596fa394c4a7a03070d9031b3067b79c8d4
    Branch: 
    Author: Pisarenko Grigoriy <grigoriypisar@ydb.tech>
    Summary: Merge 79a09f7950d025ac7651c8845c6ab578953fef41 into cd0aab03f9646e0cb890d748a31ed35e4e9d9963
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-7wapoxkjru    Host information: 
        Linux ghrun-7wapoxkjru 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-09 12:49:41,855 - DEBUG - ya.test.1986723  - get_binary: Binary was found by /home/runner/.ya/build/build_root/cm7y/0043b2/ydb/apps/ydbd/ydbd
2025-12-09 12:49:41,857 - DEBUG - library.python.filelock.1986723  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/11236
2025-12-09 12:49:41,859 - DEBUG - ydb.tests.library.harness.kikimr_runner.1986723  - start: Working directory: /home/runner/.ya/build/build_root/cm7y/0043b2/r3tmp/kikimr_cluster_ahskr965
2025-12-09 12:49:41,899 - DEBUG - ya.test.1986723  - get_binary: Binary was found by /home/runner/.ya/build/build_root/cm7y/0043b2/ydb/apps/ydbd/ydbd
2025-12-09 12:49:41,900 - DEBUG - library.python.filelock.1986723  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/25932
2025-12-09 12:49:41,901 - DEBUG - library.python.filelock.1986723  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/4839
2025-12-09 12:49:41,901 - DEBUG - library.python.filelock.1986723  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/20112
2025-12-09 12:49:41,902 - DEBUG - library.python.filelock.1986723  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/13154
2025-12-09 12:49:41,903 - INFO - ydb.tests.library.harness.kikimr_runner.1986723  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/cm7y/0043b2/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk1/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_12_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.12/cluster/kikimr_configs"
2025-12-09 12:49:41,903 - INFO - ydb.tests.library.harness.kikimr_runner.1986723  - __make_run_command: Final command: /home/runner/.ya/build/build_root/cm7y/0043b2/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/cm7y/0043b2/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk1/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_12_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.12/cluster/node_1/logfile_1l2nb0ln.log --grpc-port=25932 --mon-port=4839 --ic-port=11236
2025-12-09 12:49:41,904 - DEBUG - ydb.tests.library.harness.kikimr_runner.1986723  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:25932/1, disk_size 68719476736
2025-12-09 12:49:41,904 - INFO - ydb.tests.library.harness.kikimr_runner.1986723  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/cm7y/0043b2/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk1/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_12_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.12/cluster/kikimr_configs"
2025-12-09 12:49:41,905 - INFO - ydb.tests.library.harness.kikimr_runner.1986723  - __make_run_command: Final command: /home/runner/.ya/build/build_root/cm7y/0043b2/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/cm7y/0043b2/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk1/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_12_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.12/cluster/node_1/logfile_1l2nb0ln.log --grpc-port=25932 --mon-port=4839 --ic-port=11236
2025-12-09 12:49:41,910 - DEBUG - ya.test.1986723  - execute: Executing '('/home/runner/.ya/build/build_root/cm7y/0043b2/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/cm7y/0043b2/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk1/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_12_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.12/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/cm7y/0043b2/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk1/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_12_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.12/cluster/node_1/logfile_1l2nb0ln.log', '--grpc-port=25932', '--mon-port=4839', '--ic-port=11236')' in '/home/runner/.ya/build/build_root/cm7y/0043b2/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk1/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_12_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.12/cluster/node_1' (no wait)
2025-12-09 12:49:41,926 - DEBUG - ya.test.1986723  - execute: Command pid: 1988606
2025-12-09 12:49:41,927 - INFO - ydb.tests.library.harness.kikimr_runner.1986723  - start: Started node localhost:25932/1
2025-12-09 12:49:41,929 - DEBUG - ya.test.1986723  - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-12-09 12:49:41,930 - DEBUG - ya.test.1986723  - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-12-09 12:49:41,930 - DEBUG - ya.test.1986723  - execute: Executing '['/home/runner/.ya/build/build_root/cm7y/0043b2/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-09 12:49:41,942 - DEBUG - ya.test.1986723  - execute: Command pid: 1988610
2025-12-09 12:49:43,181 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988610) rc: 0
2025-12-09 12:49:43,181 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988610) elapsed time (sec): 1.2378880977630615
2025-12-09 12:49:43,182 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988610) idrss: 0
2025-12-09 12:49:43,182 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988610) inblock: 0
2025-12-09 12:49:43,183 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988610) isrss: 0
2025-12-09 12:49:43,183 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988610) ixrss: 0
2025-12-09 12:49:43,183 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988610) majflt: 0
2025-12-09 12:49:43,183 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988610) maxrss: 512668
2025-12-09 12:49:43,184 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988610) minflt: 45755
2025-12-09 12:49:43,184 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988610) msgrcv: 0
2025-12-09 12:49:43,184 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988610) msgsnd: 0
2025-12-09 12:49:43,185 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988610) nivcsw: 173
2025-12-09 12:49:43,189 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988610) nsignals: 0
2025-12-09 12:49:43,190 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988610) nswap: 0
2025-12-09 12:49:43,190 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988610) nvcsw: 14
2025-12-09 12:49:43,191 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988610) oublock: 8
2025-12-09 12:49:43,191 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988610) stime: 0.19291899999999998
2025-12-09 12:49:43,191 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988610) utime: 0.49106099999999997
2025-12-09 12:49:43,191 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988610) wtime: 1.25
2025-12-09 12:49:43,192 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988610) output:
Git info:
    Commit: ddb9b596fa394c4a7a03070d9031b3067b79c8d4
    Branch: 
    Author: Pisarenko Grigoriy <grigoriypisar@ydb.tech>
    Summary: Merge 79a09f7950d025ac7651c8845c6ab578953fef41 into cd0aab03f9646e0cb890d748a31ed35e4e9d9963
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-7wapoxkjru    Host information: 
        Linux ghrun-7wapoxkjru 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-09 12:49:43,192 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1988610) errors:

2025-12-09 12:49:43,193 - INFO - ydb.tests.library.harness.kikimr_runner.1986723  - start: Node 1 version:
Git info:
    Commit: ddb9b596fa394c4a7a03070d9031b3067b79c8d4
    Branch: 
    Author: Pisarenko Grigoriy <grigoriypisar@ydb.tech>
    Summary: Merge 79a09f7950d025ac7651c8845c6ab578953fef41 into cd0aab03f9646e0cb890d748a31ed35e4e9d9963
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-7wapoxkjru    Host information: 
        Linux ghrun-7wapoxkjru 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64
2025-12-09 12:49:48,435 - DEBUG - ya.test.1986723  - get_binary: Binary was found by /home/runner/.ya/build/build_root/cm7y/0043b2/ydb/apps/ydbd/ydbd
2025-12-09 12:49:48,436 - DEBUG - ydb.tests.library.harness.kikimr_runner.1986723  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/cm7y/0043b2/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:25932', '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: 11236\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-12-09 12:49:48,437 - DEBUG - ya.test.1986723  - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-12-09 12:49:48,437 - DEBUG - ya.test.1986723  - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-12-09 12:49:48,438 - DEBUG - ya.test.1986723  - execute: Executing '['/home/runner/.ya/build/build_root/cm7y/0043b2/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:25932', '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: 11236\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-12-09 12:49:48,442 - DEBUG - ya.test.1986723  - execute: Command pid: 1990854
2025-12-09 12:49:49,513 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1990854) rc: 0
2025-12-09 12:49:49,514 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1990854) elapsed time (sec): 1.0700087547302246
2025-12-09 12:49:49,514 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1990854) idrss: 0
2025-12-09 12:49:49,514 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1990854) inblock: 0
2025-12-09 12:49:49,515 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1990854) isrss: 0
2025-12-09 12:49:49,515 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1990854) ixrss: 0
2025-12-09 12:49:49,515 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1990854) majflt: 0
2025-12-09 12:49:49,515 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1990854) maxrss: 612168
2025-12-09 12:49:49,516 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1990854) minflt: 52192
2025-12-09 12:49:49,516 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1990854) msgrcv: 0
2025-12-09 12:49:49,516 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1990854) msgsnd: 0
2025-12-09 12:49:49,516 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1990854) nivcsw: 129
2025-12-09 12:49:49,516 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1990854) nsignals: 0
2025-12-09 12:49:49,516 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1990854) nswap: 0
2025-12-09 12:49:49,517 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1990854) nvcsw: 641
2025-12-09 12:49:49,517 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1990854) oublock: 8
2025-12-09 12:49:49,517 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1990854) stime: 0.25948499999999997
2025-12-09 12:49:49,517 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1990854) utime: 0.548245
2025-12-09 12:49:49,517 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1990854) wtime: 1.074
2025-12-09 12:49:49,518 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1990854) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-12-09 12:49:49,518 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1990854) errors:

2025-12-09 12:49:49,519 - DEBUG - ya.test.1986723  - get_binary: Binary was found by /home/runner/.ya/build/build_root/cm7y/0043b2/ydb/apps/ydbd/ydbd
2025-12-09 12:49:49,520 - DEBUG - ydb.tests.library.harness.kikimr_runner.1986723  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/cm7y/0043b2/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:25932', '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-09 12:49:49,521 - DEBUG - ya.test.1986723  - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-12-09 12:49:49,521 - DEBUG - ya.test.1986723  - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-12-09 12:49:49,522 - DEBUG - ya.test.1986723  - execute: Executing '['/home/runner/.ya/build/build_root/cm7y/0043b2/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:25932', '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-09 12:49:49,523 - DEBUG - ya.test.1986723  - execute: Command pid: 1991050
2025-12-09 12:49:51,128 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1991050) rc: 0
2025-12-09 12:49:51,129 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1991050) elapsed time (sec): 1.6043379306793213
2025-12-09 12:49:51,129 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1991050) idrss: 0
2025-12-09 12:49:51,129 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1991050) inblock: 0
2025-12-09 12:49:51,130 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1991050) isrss: 0
2025-12-09 12:49:51,130 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1991050) ixrss: 0
2025-12-09 12:49:51,130 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1991050) majflt: 0
2025-12-09 12:49:51,130 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1991050) maxrss: 612508
2025-12-09 12:49:51,131 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1991050) minflt: 52169
2025-12-09 12:49:51,131 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1991050) msgrcv: 0
2025-12-09 12:49:51,131 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1991050) msgsnd: 0
2025-12-09 12:49:51,131 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1991050) nivcsw: 242
2025-12-09 12:49:51,132 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1991050) nsignals: 0
2025-12-09 12:49:51,132 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1991050) nswap: 0
2025-12-09 12:49:51,132 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1991050) nvcsw: 366
2025-12-09 12:49:51,132 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1991050) oublock: 8
2025-12-09 12:49:51,133 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1991050) stime: 0.25299099999999997
2025-12-09 12:49:51,133 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1991050) utime: 0.567638
2025-12-09 12:49:51,133 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1991050) wtime: 1.606
2025-12-09 12:49:51,138 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1991050) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-12-09 12:49:51,138 - DEBUG - ya.test.1986723  - _save_outputs: Command (pid 1991050) errors:

2025-12-09 12:49:51,138 - INFO - ydb.tests.library.harness.kikimr_runner.1986723  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-12-09 12:49:51,274 - INFO - ydb.tests.library.harness.kikimr_runner.1986723  - __run: Cluster started and initialized
2025-12-09 12:49:51,359 - DEBUG - ydb.connection.1986723  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-09 12:49:51,370 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1986723  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-09 12:49:51,370 - DEBUG - ydb.connection.1986723  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-09 12:49:51,406 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1986723  - context_resolve: Resolving endpoints for database /Root
2025-12-09 12:49:51,407 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ListEndpoints, 1873515e-5ff2-414e-b38d-c4f42d534efc, localhost:25932): creating call state
2025-12-09 12:49:51,408 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ListEndpoints, 1873515e-5ff2-414e-b38d-c4f42d534efc, localhost:25932): request = { database: "/Root" }
2025-12-09 12:49:51,451 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ListEndpoints, 1873515e-5ff2-414e-b38d-c4f42d534efc, localhost:25932): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-7wapoxkjru.auto.internal" port: 25932 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-09 12:49:51,470 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1986723  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-7wapoxkjru.auto.internal:25932, location 1, ssl: False>]>
2025-12-09 12:49:51,471 - DEBUG - ydb.connection.1986723  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-09 12:49:51,489 - DEBUG - ydb.connection.1986723  - close: Closing channel for endpoint localhost:25932
2025-12-09 12:49:51,491 - DEBUG - ydb.query.pool.1986723  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-09 12:49:51,492 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(CreateSession, e8ada2ca-802c-4a65-a981-86a0268c4d1a, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:49:51,493 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(CreateSession, e8ada2ca-802c-4a65-a981-86a0268c4d1a, ghrun-7wapoxkjru.auto.internal:25932): request = {  }
2025-12-09 12:49:51,500 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(CreateSession, e8ada2ca-802c-4a65-a981-86a0268c4d1a, ghrun-7wapoxkjru.auto.internal:25932): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" node_id: 1 }
2025-12-09 12:49:51,500 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(AttachSession, 84144253-5a94-4a5d-aafa-98b5d3058730, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:49:51,501 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(AttachSession, 84144253-5a94-4a5d-aafa-98b5d3058730, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" }
2025-12-09 12:49:51,503 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(AttachSession, 84144253-5a94-4a5d-aafa-98b5d3058730, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:49:51,521 - DEBUG - ydb.query.pool.1986723  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:49:51,522 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, d69ef815-dbbe-4b8c-85af-6bee4ba70b61, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:49:51,523 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, d69ef815-dbbe-4b8c-85af-6bee4ba70b61, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:49:51,525 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, d69ef815-dbbe-4b8c-85af-6bee4ba70b61, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:49:56,650 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:49:56,650 - INFO - __tests__.alter_compression.1986723  - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-12-09 12:49:56,651 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:49:56,651 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 1857bb57-87f5-41f8-9f75-c4dfaf166dbb, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:49:56,652 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 1857bb57-87f5-41f8-9f75-c4dfaf166dbb, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:49:56,654 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 1857bb57-87f5-41f8-9f75-c4dfaf166dbb, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:49:58,363 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:49:58,364 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:49:58,365 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 3d62b789-c864-4916-8ba1-05076a9c90b0, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:49:58,366 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 3d62b789-c864-4916-8ba1-05076a9c90b0, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:49:58,367 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 3d62b789-c864-4916-8ba1-05076a9c90b0, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:49:59,786 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:49:59,786 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:49:59,787 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 3363745e-71ae-4dfa-ad41-827425da25d7, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:49:59,788 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 3363745e-71ae-4dfa-ad41-827425da25d7, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:49:59,789 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 3363745e-71ae-4dfa-ad41-827425da25d7, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:01,757 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:01,758 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:01,758 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 5821226a-c9c5-4e75-b7f0-1cdb7eb6aee7, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:01,771 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 5821226a-c9c5-4e75-b7f0-1cdb7eb6aee7, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:01,773 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 5821226a-c9c5-4e75-b7f0-1cdb7eb6aee7, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:05,596 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:05,596 - INFO - __tests__.alter_compression.1986723  - 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-09 12:50:05,597 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:05,597 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 46353ddb-452e-4154-a19b-6ca4d52b3a21, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:05,598 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 46353ddb-452e-4154-a19b-6ca4d52b3a21, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:05,599 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 46353ddb-452e-4154-a19b-6ca4d52b3a21, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:07,393 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:07,394 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:07,395 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 904893cb-a4e0-4230-a29d-229deb7c018e, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:07,395 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 904893cb-a4e0-4230-a29d-229deb7c018e, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:07,397 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 904893cb-a4e0-4230-a29d-229deb7c018e, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:07,711 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:07,712 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:07,712 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, fb2fe6f4-489c-40b2-9957-3949b9f28068, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:07,713 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, fb2fe6f4-489c-40b2-9957-3949b9f28068, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:07,716 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, fb2fe6f4-489c-40b2-9957-3949b9f28068, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:08,255 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:08,256 - INFO - __tests__.alter_compression.1986723  - 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-09 12:50:08,256 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:08,257 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 6796bd6b-3134-4d5e-8ed3-458fdb52eeb0, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:08,257 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 6796bd6b-3134-4d5e-8ed3-458fdb52eeb0, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:08,270 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 6796bd6b-3134-4d5e-8ed3-458fdb52eeb0, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:09,754 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:09,770 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:09,771 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, df427868-2603-45e8-b8d2-be5b8461d467, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:09,771 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, df427868-2603-45e8-b8d2-be5b8461d467, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:09,773 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, df427868-2603-45e8-b8d2-be5b8461d467, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:10,499 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:10,500 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:10,501 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, f5a87c21-f3fb-4276-8c6f-76835af408ba, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:10,502 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, f5a87c21-f3fb-4276-8c6f-76835af408ba, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:10,504 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, f5a87c21-f3fb-4276-8c6f-76835af408ba, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:11,174 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:11,175 - INFO - __tests__.alter_compression.1986723  - 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-09 12:50:11,175 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:11,176 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 63033254-ab94-493b-8c15-36c05bb75ebb, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:11,177 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 63033254-ab94-493b-8c15-36c05bb75ebb, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:11,178 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 63033254-ab94-493b-8c15-36c05bb75ebb, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:12,815 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:12,816 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:12,816 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, c9e5f76a-99af-41c1-9bf0-4e3b6ce31e1b, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:12,817 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, c9e5f76a-99af-41c1-9bf0-4e3b6ce31e1b, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:12,818 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, c9e5f76a-99af-41c1-9bf0-4e3b6ce31e1b, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:13,051 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:13,052 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:13,052 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 7f01587e-36b2-40e4-8f6f-8916ae0b2bb9, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:13,053 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 7f01587e-36b2-40e4-8f6f-8916ae0b2bb9, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:13,055 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 7f01587e-36b2-40e4-8f6f-8916ae0b2bb9, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:13,384 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:13,384 - INFO - __tests__.alter_compression.1986723  - 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-09 12:50:13,385 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:13,385 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 3465ce00-4c05-41c2-b999-9c7cb4c55b6a, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:13,386 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 3465ce00-4c05-41c2-b999-9c7cb4c55b6a, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:13,389 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 3465ce00-4c05-41c2-b999-9c7cb4c55b6a, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:14,562 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:14,562 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:14,563 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 925757d7-6af0-4cb4-bd23-e12fe08cc5bf, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:14,565 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 925757d7-6af0-4cb4-bd23-e12fe08cc5bf, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:14,566 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 925757d7-6af0-4cb4-bd23-e12fe08cc5bf, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:14,875 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:14,876 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:14,877 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 5c2df6a5-86e4-4c05-9490-08512abe27a0, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:14,878 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 5c2df6a5-86e4-4c05-9490-08512abe27a0, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:14,880 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 5c2df6a5-86e4-4c05-9490-08512abe27a0, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:15,459 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:15,460 - INFO - __tests__.alter_compression.1986723  - 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-09 12:50:15,460 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:15,461 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 3112c37e-a36f-401e-b092-f0f7a7e17e20, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:15,462 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 3112c37e-a36f-401e-b092-f0f7a7e17e20, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:15,474 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 3112c37e-a36f-401e-b092-f0f7a7e17e20, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:16,416 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:16,417 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:16,417 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, df186bd1-cea8-457e-8216-8d04994412bc, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:16,418 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, df186bd1-cea8-457e-8216-8d04994412bc, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:16,421 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, df186bd1-cea8-457e-8216-8d04994412bc, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:16,755 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:16,756 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:16,756 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 72502135-efb5-4899-8ba8-743b2503bc8c, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:16,757 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 72502135-efb5-4899-8ba8-743b2503bc8c, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:16,759 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 72502135-efb5-4899-8ba8-743b2503bc8c, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:17,233 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:17,234 - INFO - __tests__.alter_compression.1986723  - 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-09 12:50:17,234 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:17,235 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, e2301906-d14c-499a-8c44-d7a7029c75ce, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:17,236 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, e2301906-d14c-499a-8c44-d7a7029c75ce, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:17,237 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, e2301906-d14c-499a-8c44-d7a7029c75ce, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:18,485 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:18,486 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:18,486 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, a39eaac2-e7bd-48e3-b6dc-8c82f17f820e, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:18,487 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, a39eaac2-e7bd-48e3-b6dc-8c82f17f820e, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:18,488 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, a39eaac2-e7bd-48e3-b6dc-8c82f17f820e, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:18,803 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:18,804 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:18,805 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 57b9d4d9-c881-4a15-9b0b-2fb56959336b, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:18,806 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 57b9d4d9-c881-4a15-9b0b-2fb56959336b, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:18,813 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 57b9d4d9-c881-4a15-9b0b-2fb56959336b, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:20,093 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:20,108 - INFO - __tests__.alter_compression.1986723  - 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-09 12:50:20,109 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:20,109 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 54b4fcb2-adfe-47e3-b670-e1946ab4a311, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:20,110 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 54b4fcb2-adfe-47e3-b670-e1946ab4a311, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:20,119 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 54b4fcb2-adfe-47e3-b670-e1946ab4a311, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:21,765 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:21,766 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:21,767 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, a9490a1a-5223-41b6-a657-8c26a2cf9017, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:21,768 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, a9490a1a-5223-41b6-a657-8c26a2cf9017, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:21,770 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, a9490a1a-5223-41b6-a657-8c26a2cf9017, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:22,754 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:22,755 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:22,755 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, bac89583-163e-4ff9-9e28-c4dd112ad0ad, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:22,756 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, bac89583-163e-4ff9-9e28-c4dd112ad0ad, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:22,762 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, bac89583-163e-4ff9-9e28-c4dd112ad0ad, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:23,833 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:23,838 - INFO - __tests__.alter_compression.1986723  - 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-09 12:50:23,839 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:23,839 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 70b6688b-d56c-4561-ae17-4edbd1f4e9b4, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:23,840 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 70b6688b-d56c-4561-ae17-4edbd1f4e9b4, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:23,842 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 70b6688b-d56c-4561-ae17-4edbd1f4e9b4, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:25,103 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:25,104 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:25,104 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, b89d267e-2432-4316-ad94-1ae8144e7065, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:25,105 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, b89d267e-2432-4316-ad94-1ae8144e7065, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:25,106 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, b89d267e-2432-4316-ad94-1ae8144e7065, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:25,399 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:25,399 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:25,400 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 81ffc4b7-db79-4c98-afe9-081cd311eea7, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:25,401 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 81ffc4b7-db79-4c98-afe9-081cd311eea7, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:25,402 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 81ffc4b7-db79-4c98-afe9-081cd311eea7, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:26,899 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:26,900 - INFO - __tests__.alter_compression.1986723  - 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-09 12:50:26,901 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:26,901 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 7e901084-0046-447e-a44d-75fe47ee85ef, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:26,902 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 7e901084-0046-447e-a44d-75fe47ee85ef, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:26,904 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 7e901084-0046-447e-a44d-75fe47ee85ef, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:28,578 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:28,598 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:28,622 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 765b5323-dd6a-4897-9279-6590f8e1957b, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:28,629 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 765b5323-dd6a-4897-9279-6590f8e1957b, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:28,698 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 765b5323-dd6a-4897-9279-6590f8e1957b, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:28,986 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:28,991 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:28,992 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, fd908e8b-c886-44d0-9fa8-326d3f01336f, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:28,993 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, fd908e8b-c886-44d0-9fa8-326d3f01336f, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:28,995 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, fd908e8b-c886-44d0-9fa8-326d3f01336f, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:29,738 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:29,741 - INFO - __tests__.alter_compression.1986723  - 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-09 12:50:29,773 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:29,794 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 2988c597-e0e9-47c8-b18b-76a9a58a9e52, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:29,809 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 2988c597-e0e9-47c8-b18b-76a9a58a9e52, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:29,828 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 2988c597-e0e9-47c8-b18b-76a9a58a9e52, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:31,035 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:31,036 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:31,037 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, efd2b41a-a821-4878-bca1-85f541a1f0bb, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:31,038 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, efd2b41a-a821-4878-bca1-85f541a1f0bb, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:31,039 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, efd2b41a-a821-4878-bca1-85f541a1f0bb, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:31,477 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:31,479 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:31,480 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, c49caf4e-9b28-4aab-a881-7ecbd062d17f, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:31,481 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, c49caf4e-9b28-4aab-a881-7ecbd062d17f, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:31,487 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, c49caf4e-9b28-4aab-a881-7ecbd062d17f, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:31,985 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:31,986 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:31,987 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 27f035aa-c826-46c9-addd-6005f06734a3, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:31,988 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 27f035aa-c826-46c9-addd-6005f06734a3, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:32,035 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 27f035aa-c826-46c9-addd-6005f06734a3, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:40,789 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:50,866 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:50,867 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 0626553f-8c37-44c0-b3a8-c879960a2eae, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:50,907 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 0626553f-8c37-44c0-b3a8-c879960a2eae, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:50,915 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 0626553f-8c37-44c0-b3a8-c879960a2eae, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:50:55,453 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:55,569 - INFO - root.1986723  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-12-09 12:50:55,570 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:50:55,571 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 64774248-cb80-4dd9-94f9-6598e13d0266, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:50:55,572 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 64774248-cb80-4dd9-94f9-6598e13d0266, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:50:55,578 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 64774248-cb80-4dd9-94f9-6598e13d0266, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:02,047 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:04,333 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1986723  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-09 12:51:04,335 - DEBUG - ydb.connection.1986723  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-09 12:51:04,345 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1986723  - context_resolve: Resolving endpoints for database /Root
2025-12-09 12:51:04,345 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ListEndpoints, 593592f0-74f0-4b6b-a63e-7044dcb4bcc6, localhost:25932): creating call state
2025-12-09 12:51:04,346 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ListEndpoints, 593592f0-74f0-4b6b-a63e-7044dcb4bcc6, localhost:25932): request = { database: "/Root" }
2025-12-09 12:51:04,355 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ListEndpoints, 593592f0-74f0-4b6b-a63e-7044dcb4bcc6, localhost:25932): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-7wapoxkjru.auto.internal" port: 25932 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-09 12:51:04,356 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1986723  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-7wapoxkjru.auto.internal:25932, location 1, ssl: False>]>
2025-12-09 12:51:04,356 - DEBUG - ydb.connection.1986723  - close: Closing channel for endpoint localhost:25932
2025-12-09 12:51:12,097 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:12,113 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, a04bd1ca-0d8f-4c87-b0da-bc0b62bc5005, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:12,114 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, a04bd1ca-0d8f-4c87-b0da-bc0b62bc5005, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:51:12,115 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, a04bd1ca-0d8f-4c87-b0da-bc0b62bc5005, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:12,838 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:12,841 - INFO - root.1986723  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8009216)
2025-12-09 12:51:12,841 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:12,842 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, acb41794-5a57-4b1f-9c55-8ba555005396, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:12,843 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, acb41794-5a57-4b1f-9c55-8ba555005396, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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-09 12:51:12,844 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, acb41794-5a57-4b1f-9c55-8ba555005396, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:13,138 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:13,141 - INFO - ya.test.1986723  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_12_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 12])
2025-12-09 12:51:13,141 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:13,142 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, e8a9302a-016b-44a1-b1ff-ee180a26f686, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:13,143 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, e8a9302a-016b-44a1-b1ff-ee180a26f686, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_12_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 12)\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-09 12:51:13,144 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, e8a9302a-016b-44a1-b1ff-ee180a26f686, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:15,927 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:15,928 - INFO - __tests__.alter_compression.1986723  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_12_compression created
2025-12-09 12:51:15,928 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:15,929 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 3bb58947-b0e9-49a7-85df-8ac136252647, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:15,930 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 3bb58947-b0e9-49a7-85df-8ac136252647, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_12_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:51:15,931 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 3bb58947-b0e9-49a7-85df-8ac136252647, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:16,760 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:16,761 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:16,762 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 3d0d5783-2312-4936-b42f-9e44fdcc389c, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:16,763 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 3d0d5783-2312-4936-b42f-9e44fdcc389c, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:51:16,764 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 3d0d5783-2312-4936-b42f-9e44fdcc389c, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:19,831 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:19,832 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:19,833 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 625e4888-b197-4afa-897e-95c80d38f8ff, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:19,834 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 625e4888-b197-4afa-897e-95c80d38f8ff, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:51:19,837 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 625e4888-b197-4afa-897e-95c80d38f8ff, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:20,623 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:20,624 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:20,625 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 22a5b747-aa78-4a98-a9c6-9f6fd9f4bdc4, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:20,625 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 22a5b747-aa78-4a98-a9c6-9f6fd9f4bdc4, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:51:20,630 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 22a5b747-aa78-4a98-a9c6-9f6fd9f4bdc4, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:22,180 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:22,181 - INFO - __tests__.alter_compression.1986723  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 375776, 'BlobCount': 128}}
2025-12-09 12:51:22,182 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:22,183 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 27b67530-5ae8-492d-a9eb-d2955e837714, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:22,184 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 27b67530-5ae8-492d-a9eb-d2955e837714, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:51:22,189 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 27b67530-5ae8-492d-a9eb-d2955e837714, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:24,489 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:24,490 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:24,491 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, fbc5c41b-e3a3-4478-bf02-250664036518, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:24,491 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, fbc5c41b-e3a3-4478-bf02-250664036518, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:51:24,493 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, fbc5c41b-e3a3-4478-bf02-250664036518, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:24,760 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:24,761 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:24,762 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 5ae2ee41-df07-4200-8e4e-df2aafa532dc, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:24,763 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 5ae2ee41-df07-4200-8e4e-df2aafa532dc, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:51:24,765 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 5ae2ee41-df07-4200-8e4e-df2aafa532dc, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:25,086 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:25,087 - INFO - __tests__.alter_compression.1986723  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 753024, 'BlobCount': 256}}
2025-12-09 12:51:25,087 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:25,088 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 2aef95e5-2fdb-4e87-b8e8-7f0afa2ad418, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:25,089 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 2aef95e5-2fdb-4e87-b8e8-7f0afa2ad418, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:51:25,091 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 2aef95e5-2fdb-4e87-b8e8-7f0afa2ad418, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:27,362 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:27,363 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:27,364 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, b47f3634-1acf-4239-8ee5-1ace920b4af6, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:27,364 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, b47f3634-1acf-4239-8ee5-1ace920b4af6, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:51:27,370 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, b47f3634-1acf-4239-8ee5-1ace920b4af6, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:27,635 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:27,636 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:27,636 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 2fe5c527-0986-479c-8fd9-8762df0e9d7a, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:27,637 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 2fe5c527-0986-479c-8fd9-8762df0e9d7a, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:51:27,638 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 2fe5c527-0986-479c-8fd9-8762df0e9d7a, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:28,176 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:28,177 - INFO - __tests__.alter_compression.1986723  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 1129904, 'BlobCount': 384}}
2025-12-09 12:51:28,177 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:28,178 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 9c005ca9-59a1-476d-9ec2-71002da01b89, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:28,179 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 9c005ca9-59a1-476d-9ec2-71002da01b89, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:51:28,180 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 9c005ca9-59a1-476d-9ec2-71002da01b89, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:30,863 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:30,864 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:30,865 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 17eb3075-b38d-42f5-bdff-aebecc0ac267, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:30,874 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 17eb3075-b38d-42f5-bdff-aebecc0ac267, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:51:30,876 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 17eb3075-b38d-42f5-bdff-aebecc0ac267, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:31,115 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:31,116 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:31,117 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, e02f9676-3991-465e-a75a-99593b892383, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:31,117 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, e02f9676-3991-465e-a75a-99593b892383, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:51:31,118 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, e02f9676-3991-465e-a75a-99593b892383, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:31,528 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:31,529 - INFO - __tests__.alter_compression.1986723  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1507088, 'BlobCount': 512}}
2025-12-09 12:51:31,529 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:31,530 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 4ff9cd2a-b2cc-4800-aed5-a5d602e5359d, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:31,531 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 4ff9cd2a-b2cc-4800-aed5-a5d602e5359d, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:51:31,532 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 4ff9cd2a-b2cc-4800-aed5-a5d602e5359d, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:34,104 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:34,105 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:34,106 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 34fe95c1-c64e-4432-bf18-615569ae984f, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:34,107 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 34fe95c1-c64e-4432-bf18-615569ae984f, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:51:34,108 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 34fe95c1-c64e-4432-bf18-615569ae984f, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:34,582 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:34,583 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:34,584 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 4e191591-a570-4c42-93a0-300206d97f41, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:34,635 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 4e191591-a570-4c42-93a0-300206d97f41, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:51:34,639 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 4e191591-a570-4c42-93a0-300206d97f41, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:35,170 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:35,171 - INFO - __tests__.alter_compression.1986723  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1883952, 'BlobCount': 640}}
2025-12-09 12:51:35,171 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:35,172 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, aead0aaa-807b-4129-8012-d29f75845fb9, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:35,173 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, aead0aaa-807b-4129-8012-d29f75845fb9, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:51:35,175 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, aead0aaa-807b-4129-8012-d29f75845fb9, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:39,395 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:39,396 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:39,396 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 84622f36-b7e9-49ad-8bc2-159ebc30c147, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:39,397 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 84622f36-b7e9-49ad-8bc2-159ebc30c147, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:51:39,398 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 84622f36-b7e9-49ad-8bc2-159ebc30c147, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:40,021 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:40,049 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:40,050 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 88011e47-741a-4e9c-9e44-cd35a41a89e5, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:40,051 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 88011e47-741a-4e9c-9e44-cd35a41a89e5, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:51:40,052 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 88011e47-741a-4e9c-9e44-cd35a41a89e5, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:40,739 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:40,740 - INFO - __tests__.alter_compression.1986723  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 2261152, 'BlobCount': 768}}
2025-12-09 12:51:40,741 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:40,741 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 8842e6cc-fe29-4340-bb6f-31483540c6e0, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:40,742 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 8842e6cc-fe29-4340-bb6f-31483540c6e0, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:51:40,766 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 8842e6cc-fe29-4340-bb6f-31483540c6e0, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:43,818 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:43,819 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:43,820 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 220797e5-1c55-4c29-919b-937824189490, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:43,821 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 220797e5-1c55-4c29-919b-937824189490, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:51:43,822 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 220797e5-1c55-4c29-919b-937824189490, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:44,544 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:44,544 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:44,545 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 06e66069-4718-4b1d-8e0d-1b1b59712d2f, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:44,546 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 06e66069-4718-4b1d-8e0d-1b1b59712d2f, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:51:44,547 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 06e66069-4718-4b1d-8e0d-1b1b59712d2f, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:45,165 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:45,165 - INFO - __tests__.alter_compression.1986723  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2638128, 'BlobCount': 896}}
2025-12-09 12:51:45,166 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:45,166 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, e318a701-26c1-4ba7-a59b-7d502611b4b2, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:45,167 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, e318a701-26c1-4ba7-a59b-7d502611b4b2, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:51:45,169 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, e318a701-26c1-4ba7-a59b-7d502611b4b2, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:48,230 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:48,231 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:48,232 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, cb043590-bc81-42c2-9883-1f7c2fb03bd6, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:48,233 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, cb043590-bc81-42c2-9883-1f7c2fb03bd6, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:51:48,234 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, cb043590-bc81-42c2-9883-1f7c2fb03bd6, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:49,554 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:49,555 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:49,556 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 0d23bae2-2d35-4bd1-b18e-2bdb856c1c84, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:49,556 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 0d23bae2-2d35-4bd1-b18e-2bdb856c1c84, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:51:49,566 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 0d23bae2-2d35-4bd1-b18e-2bdb856c1c84, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:51,191 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:51,192 - INFO - __tests__.alter_compression.1986723  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 3015296, 'BlobCount': 1024}}
2025-12-09 12:51:51,193 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:51,193 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 1e38dbc1-4f38-4450-b6cc-13b3253c69a2, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:51,195 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 1e38dbc1-4f38-4450-b6cc-13b3253c69a2, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:51:51,208 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 1e38dbc1-4f38-4450-b6cc-13b3253c69a2, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:56,902 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:56,903 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:56,904 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, f11110cc-5451-47c9-9db4-6651c9969e99, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:56,905 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, f11110cc-5451-47c9-9db4-6651c9969e99, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:51:56,914 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, f11110cc-5451-47c9-9db4-6651c9969e99, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:57,668 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:57,669 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:57,669 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, d94d75d4-db98-4610-b1e2-d44dc7d44a84, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:57,670 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, d94d75d4-db98-4610-b1e2-d44dc7d44a84, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:51:57,673 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, d94d75d4-db98-4610-b1e2-d44dc7d44a84, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:51:59,199 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:59,199 - INFO - __tests__.alter_compression.1986723  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 3392304, 'BlobCount': 1152}}
2025-12-09 12:51:59,200 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:51:59,201 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 91d70a5b-54f6-4b10-8a8f-ecd5af2f409e, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:51:59,201 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 91d70a5b-54f6-4b10-8a8f-ecd5af2f409e, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:51:59,203 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 91d70a5b-54f6-4b10-8a8f-ecd5af2f409e, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:52:03,458 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:52:03,458 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:52:03,459 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 6f53abd2-776a-4442-8ee5-c7183661769a, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:52:03,460 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 6f53abd2-776a-4442-8ee5-c7183661769a, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:52:03,464 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 6f53abd2-776a-4442-8ee5-c7183661769a, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:52:03,853 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:52:03,859 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:52:03,860 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, d105dba3-a087-4580-93d4-5eec4d88a007, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:52:03,861 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, d105dba3-a087-4580-93d4-5eec4d88a007, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:52:03,862 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, d105dba3-a087-4580-93d4-5eec4d88a007, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:52:04,804 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:52:04,805 - INFO - __tests__.alter_compression.1986723  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3769616, 'BlobCount': 1280}}
2025-12-09 12:52:04,805 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:52:04,815 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 37a00ad0-9c8e-4e4f-94df-a12115c2c425, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:52:04,816 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 37a00ad0-9c8e-4e4f-94df-a12115c2c425, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_12_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-09 12:52:04,817 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 37a00ad0-9c8e-4e4f-94df-a12115c2c425, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:52:05,982 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:52:05,987 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:52:05,987 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 02a1d336-9420-40d9-876d-1d19b5f80682, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:52:05,988 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 02a1d336-9420-40d9-876d-1d19b5f80682, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:52:05,989 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 02a1d336-9420-40d9-876d-1d19b5f80682, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:52:06,339 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:52:06,340 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:52:06,340 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 98c90a71-58d8-4fd5-8645-384539c2f5e3, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:52:06,341 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 98c90a71-58d8-4fd5-8645-384539c2f5e3, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:52:06,342 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 98c90a71-58d8-4fd5-8645-384539c2f5e3, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:52:06,966 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:52:06,994 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:52:06,995 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 926c3c1e-1c72-49b9-b755-752da24e49b4, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:52:06,996 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 926c3c1e-1c72-49b9-b755-752da24e49b4, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_12_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-09 12:52:06,997 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 926c3c1e-1c72-49b9-b755-752da24e49b4, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:52:13,694 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:52:23,773 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:52:23,774 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 8dd27b66-04fa-4f3d-9b9d-606c4fd75db0, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:52:23,776 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 8dd27b66-04fa-4f3d-9b9d-606c4fd75db0, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_12_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-09 12:52:23,777 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 8dd27b66-04fa-4f3d-9b9d-606c4fd75db0, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:52:25,574 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:52:35,588 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:52:35,589 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 93adbcc9-fda7-4944-975d-f0c311982230, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:52:35,590 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 93adbcc9-fda7-4944-975d-f0c311982230, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_12_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-09 12:52:35,591 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 93adbcc9-fda7-4944-975d-f0c311982230, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:52:36,339 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:52:41,926 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1986723  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-09 12:52:41,926 - DEBUG - ydb.connection.1986723  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-09 12:52:41,947 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1986723  - context_resolve: Resolving endpoints for database /Root
2025-12-09 12:52:41,948 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ListEndpoints, 31c6e2be-9e71-471f-ae09-d9347bdc7110, localhost:25932): creating call state
2025-12-09 12:52:41,948 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ListEndpoints, 31c6e2be-9e71-471f-ae09-d9347bdc7110, localhost:25932): request = { database: "/Root" }
2025-12-09 12:52:41,958 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ListEndpoints, 31c6e2be-9e71-471f-ae09-d9347bdc7110, localhost:25932): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-7wapoxkjru.auto.internal" port: 25932 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-09 12:52:41,959 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1986723  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-7wapoxkjru.auto.internal:25932, location 1, ssl: False>]>
2025-12-09 12:52:41,959 - DEBUG - ydb.connection.1986723  - close: Closing channel for endpoint localhost:25932
2025-12-09 12:52:46,344 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:52:46,345 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 25505214-6b4e-43ec-83d7-9de736ea4602, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:52:46,346 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 25505214-6b4e-43ec-83d7-9de736ea4602, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_12_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-09 12:52:46,348 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 25505214-6b4e-43ec-83d7-9de736ea4602, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:52:47,164 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:52:47,169 - INFO - root.1986723  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_12_compression`, volumes `value` (8000000, 1465648)
2025-12-09 12:52:47,173 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:52:47,174 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 95b4531f-e45a-41d5-a324-cd1367756d6b, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:52:47,175 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 95b4531f-e45a-41d5-a324-cd1367756d6b, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" 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_12_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-09 12:52:47,176 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 95b4531f-e45a-41d5-a324-cd1367756d6b, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:52:47,452 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:52:47,453 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:52:47,453 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 38b604ba-d328-447f-8098-c54d63386cee, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:52:47,454 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 38b604ba-d328-447f-8098-c54d63386cee, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_12_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-09 12:52:47,455 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 38b604ba-d328-447f-8098-c54d63386cee, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:52:48,093 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:52:58,097 - DEBUG - ydb.query.pool.1986723  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:52:58,098 - DEBUG - ydb.connection.1986723  - _prepare_call: RpcState(ExecuteQuery, 7996a5a8-8545-43fe-9e28-626d3ec4caee, ghrun-7wapoxkjru.auto.internal:25932): creating call state
2025-12-09 12:52:58,099 - DEBUG - ydb.connection.1986723  - _log_request: RpcState(ExecuteQuery, 7996a5a8-8545-43fe-9e28-626d3ec4caee, ghrun-7wapoxkjru.auto.internal:25932): request = { session_id: "ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_12_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-09 12:52:58,100 - DEBUG - ydb.connection.1986723  - _log_response: RpcState(ExecuteQuery, 7996a5a8-8545-43fe-9e28-626d3ec4caee, ghrun-7wapoxkjru.auto.internal:25932): response = { <_MultiThreadedRendezvous object> }
2025-12-09 12:52:58,989 - DEBUG - ydb.query.pool.1986723  - release: Session returned to queue: ydb://session/3?node_id=1&id=YTgxODA1NjMtOTg1NzQ0YTctODUxN2I3N2EtNDhmNzUyNDg=
2025-12-09 12:52:59,000 - INFO - root.1986723  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_12_compression`, volumes `value` (8000000, 1465648)
2025-12-09 12:52:59,000 - INFO - root.1986723  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_12_compression` 8092160 / 1465648: 5.52121655404299
2025-12-09 12:52:59,003 - INFO - ya.test.1986723  - pytest_runtest_teardown: Test teardown
