2025-12-23 15:36:51,405 - INFO - ya.test.668724  - pytest_runtest_setup: ####################################################################################################
2025-12-23 15:36:51,406 - INFO - ya.test.668724  - pytest_runtest_setup: test_all_supported_compression[zstd_12_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 12]
2025-12-23 15:36:51,406 - INFO - ya.test.668724  - pytest_runtest_setup: ####################################################################################################
2025-12-23 15:36:51,406 - INFO - ya.test.668724  - pytest_runtest_setup: Test setup
2025-12-23 15:36:51,408 - DEBUG - ya.test.668724  - _get_command_output_file: Command out will be placed to ydbd.out
2025-12-23 15:36:51,409 - DEBUG - ya.test.668724  - _get_command_output_file: Command err will be placed to ydbd.err
2025-12-23 15:36:51,409 - DEBUG - ya.test.668724  - execute: Executing '['/home/runner/.ya/build/build_root/wyw9/00219f/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-23 15:36:51,432 - DEBUG - ya.test.668724  - execute: Command pid: 673291
2025-12-23 15:36:52,284 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673291) rc: 0
2025-12-23 15:36:52,285 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673291) elapsed time (sec): 0.850243330001831
2025-12-23 15:36:52,285 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673291) idrss: 0
2025-12-23 15:36:52,285 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673291) inblock: 0
2025-12-23 15:36:52,286 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673291) isrss: 0
2025-12-23 15:36:52,286 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673291) ixrss: 0
2025-12-23 15:36:52,286 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673291) majflt: 0
2025-12-23 15:36:52,286 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673291) maxrss: 491324
2025-12-23 15:36:52,287 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673291) minflt: 45758
2025-12-23 15:36:52,287 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673291) msgrcv: 0
2025-12-23 15:36:52,287 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673291) msgsnd: 0
2025-12-23 15:36:52,287 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673291) nivcsw: 123
2025-12-23 15:36:52,288 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673291) nsignals: 0
2025-12-23 15:36:52,288 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673291) nswap: 0
2025-12-23 15:36:52,288 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673291) nvcsw: 14
2025-12-23 15:36:52,288 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673291) oublock: 8
2025-12-23 15:36:52,289 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673291) stime: 0.18118399999999998
2025-12-23 15:36:52,289 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673291) utime: 0.499772
2025-12-23 15:36:52,289 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673291) wtime: 0.874
2025-12-23 15:36:52,290 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673291) output:
Git info:
    Commit: abc2d1f3c1b023db8ecb13b079f91fe24aeb8bee
    Branch: 
    Author: Alek5andr-Kotov <akotov@ydb.tech>
    Summary: Merge 8cd317bbcadd236db71e9829f8fc42e5bf5c2d0b into 54d3846fcfd20f009eeeabbfe05c19f647cd92d0
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-icmf7pzugu    Host information: 
        Linux ghrun-icmf7pzugu 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

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

2025-12-23 15:36:52,290 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673291) errors:

2025-12-23 15:36:52,290 - INFO - __tests__.base.668724  - _setup_ydb: Git info:
    Commit: abc2d1f3c1b023db8ecb13b079f91fe24aeb8bee
    Branch: 
    Author: Alek5andr-Kotov <akotov@ydb.tech>
    Summary: Merge 8cd317bbcadd236db71e9829f8fc42e5bf5c2d0b into 54d3846fcfd20f009eeeabbfe05c19f647cd92d0
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-icmf7pzugu    Host information: 
        Linux ghrun-icmf7pzugu 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

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

2025-12-23 15:36:52,395 - DEBUG - ya.test.668724  - get_binary: Binary was found by /home/runner/.ya/build/build_root/wyw9/00219f/ydb/apps/ydbd/ydbd
2025-12-23 15:36:52,397 - DEBUG - library.python.filelock.668724  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/21069
2025-12-23 15:36:52,399 - DEBUG - ydb.tests.library.harness.kikimr_runner.668724  - start: Working directory: /home/runner/.ya/build/build_root/wyw9/00219f/r3tmp/kikimr_cluster_h8xmcayb
2025-12-23 15:36:52,443 - DEBUG - ya.test.668724  - get_binary: Binary was found by /home/runner/.ya/build/build_root/wyw9/00219f/ydb/apps/ydbd/ydbd
2025-12-23 15:36:52,444 - DEBUG - library.python.filelock.668724  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/15967
2025-12-23 15:36:52,445 - DEBUG - library.python.filelock.668724  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/19780
2025-12-23 15:36:52,445 - DEBUG - library.python.filelock.668724  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/13904
2025-12-23 15:36:52,446 - DEBUG - library.python.filelock.668724  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/11004
2025-12-23 15:36:52,447 - INFO - ydb.tests.library.harness.kikimr_runner.668724  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/wyw9/00219f/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-23 15:36:52,447 - INFO - ydb.tests.library.harness.kikimr_runner.668724  - __make_run_command: Final command: /home/runner/.ya/build/build_root/wyw9/00219f/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/wyw9/00219f/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_ujmxho6n.log --grpc-port=15967 --mon-port=19780 --ic-port=21069
2025-12-23 15:36:52,448 - DEBUG - ydb.tests.library.harness.kikimr_runner.668724  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:15967/1, disk_size 68719476736
2025-12-23 15:36:52,448 - INFO - ydb.tests.library.harness.kikimr_runner.668724  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/wyw9/00219f/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-23 15:36:52,449 - INFO - ydb.tests.library.harness.kikimr_runner.668724  - __make_run_command: Final command: /home/runner/.ya/build/build_root/wyw9/00219f/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/wyw9/00219f/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_ujmxho6n.log --grpc-port=15967 --mon-port=19780 --ic-port=21069
2025-12-23 15:36:52,450 - DEBUG - ya.test.668724  - execute: Executing '('/home/runner/.ya/build/build_root/wyw9/00219f/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/wyw9/00219f/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/wyw9/00219f/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_ujmxho6n.log', '--grpc-port=15967', '--mon-port=19780', '--ic-port=21069')' in '/home/runner/.ya/build/build_root/wyw9/00219f/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-23 15:36:52,452 - DEBUG - ya.test.668724  - execute: Command pid: 673638
2025-12-23 15:36:52,453 - INFO - ydb.tests.library.harness.kikimr_runner.668724  - start: Started node localhost:15967/1
2025-12-23 15:36:52,454 - DEBUG - ya.test.668724  - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-12-23 15:36:52,455 - DEBUG - ya.test.668724  - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-12-23 15:36:52,455 - DEBUG - ya.test.668724  - execute: Executing '['/home/runner/.ya/build/build_root/wyw9/00219f/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-23 15:36:52,457 - DEBUG - ya.test.668724  - execute: Command pid: 673643
2025-12-23 15:36:53,253 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673643) rc: 0
2025-12-23 15:36:53,254 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673643) elapsed time (sec): 0.7955703735351562
2025-12-23 15:36:53,254 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673643) idrss: 0
2025-12-23 15:36:53,255 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673643) inblock: 0
2025-12-23 15:36:53,255 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673643) isrss: 0
2025-12-23 15:36:53,255 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673643) ixrss: 0
2025-12-23 15:36:53,255 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673643) majflt: 0
2025-12-23 15:36:53,256 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673643) maxrss: 500060
2025-12-23 15:36:53,256 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673643) minflt: 45780
2025-12-23 15:36:53,256 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673643) msgrcv: 0
2025-12-23 15:36:53,257 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673643) msgsnd: 0
2025-12-23 15:36:53,257 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673643) nivcsw: 182
2025-12-23 15:36:53,257 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673643) nsignals: 0
2025-12-23 15:36:53,257 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673643) nswap: 0
2025-12-23 15:36:53,258 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673643) nvcsw: 15
2025-12-23 15:36:53,258 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673643) oublock: 8
2025-12-23 15:36:53,258 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673643) stime: 0.24692499999999998
2025-12-23 15:36:53,259 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673643) utime: 0.451743
2025-12-23 15:36:53,259 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673643) wtime: 0.798
2025-12-23 15:36:53,259 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673643) output:
Git info:
    Commit: abc2d1f3c1b023db8ecb13b079f91fe24aeb8bee
    Branch: 
    Author: Alek5andr-Kotov <akotov@ydb.tech>
    Summary: Merge 8cd317bbcadd236db71e9829f8fc42e5bf5c2d0b into 54d3846fcfd20f009eeeabbfe05c19f647cd92d0
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-icmf7pzugu    Host information: 
        Linux ghrun-icmf7pzugu 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

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

2025-12-23 15:36:53,260 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 673643) errors:

2025-12-23 15:36:53,260 - INFO - ydb.tests.library.harness.kikimr_runner.668724  - start: Node 1 version:
Git info:
    Commit: abc2d1f3c1b023db8ecb13b079f91fe24aeb8bee
    Branch: 
    Author: Alek5andr-Kotov <akotov@ydb.tech>
    Summary: Merge 8cd317bbcadd236db71e9829f8fc42e5bf5c2d0b into 54d3846fcfd20f009eeeabbfe05c19f647cd92d0
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-icmf7pzugu    Host information: 
        Linux ghrun-icmf7pzugu 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64
2025-12-23 15:36:58,219 - DEBUG - ya.test.668724  - get_binary: Binary was found by /home/runner/.ya/build/build_root/wyw9/00219f/ydb/apps/ydbd/ydbd
2025-12-23 15:36:58,219 - DEBUG - ydb.tests.library.harness.kikimr_runner.668724  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/wyw9/00219f/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:15967', '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: 21069\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-12-23 15:36:58,220 - DEBUG - ya.test.668724  - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-12-23 15:36:58,221 - DEBUG - ya.test.668724  - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-12-23 15:36:58,222 - DEBUG - ya.test.668724  - execute: Executing '['/home/runner/.ya/build/build_root/wyw9/00219f/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:15967', '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: 21069\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-12-23 15:36:58,225 - DEBUG - ya.test.668724  - execute: Command pid: 677773
2025-12-23 15:36:59,201 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 677773) rc: 0
2025-12-23 15:36:59,202 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 677773) elapsed time (sec): 0.9750630855560303
2025-12-23 15:36:59,202 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 677773) idrss: 0
2025-12-23 15:36:59,202 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 677773) inblock: 0
2025-12-23 15:36:59,203 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 677773) isrss: 0
2025-12-23 15:36:59,203 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 677773) ixrss: 0
2025-12-23 15:36:59,203 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 677773) majflt: 0
2025-12-23 15:36:59,204 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 677773) maxrss: 596844
2025-12-23 15:36:59,205 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 677773) minflt: 52334
2025-12-23 15:36:59,205 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 677773) msgrcv: 0
2025-12-23 15:36:59,206 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 677773) msgsnd: 0
2025-12-23 15:36:59,206 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 677773) nivcsw: 169
2025-12-23 15:36:59,206 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 677773) nsignals: 0
2025-12-23 15:36:59,206 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 677773) nswap: 0
2025-12-23 15:36:59,207 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 677773) nvcsw: 903
2025-12-23 15:36:59,207 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 677773) oublock: 8
2025-12-23 15:36:59,207 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 677773) stime: 0.262063
2025-12-23 15:36:59,208 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 677773) utime: 0.585124
2025-12-23 15:36:59,208 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 677773) wtime: 0.979
2025-12-23 15:36:59,208 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 677773) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-12-23 15:36:59,209 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 677773) errors:

2025-12-23 15:36:59,215 - DEBUG - ya.test.668724  - get_binary: Binary was found by /home/runner/.ya/build/build_root/wyw9/00219f/ydb/apps/ydbd/ydbd
2025-12-23 15:36:59,216 - DEBUG - ydb.tests.library.harness.kikimr_runner.668724  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/wyw9/00219f/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:15967', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']
2025-12-23 15:36:59,217 - DEBUG - ya.test.668724  - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-12-23 15:36:59,218 - DEBUG - ya.test.668724  - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-12-23 15:36:59,218 - DEBUG - ya.test.668724  - execute: Executing '['/home/runner/.ya/build/build_root/wyw9/00219f/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:15967', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']' in 'None' (waiting)
2025-12-23 15:36:59,232 - DEBUG - ya.test.668724  - execute: Command pid: 678438
2025-12-23 15:37:00,141 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 678438) rc: 0
2025-12-23 15:37:00,141 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 678438) elapsed time (sec): 0.9074335098266602
2025-12-23 15:37:00,142 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 678438) idrss: 0
2025-12-23 15:37:00,142 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 678438) inblock: 0
2025-12-23 15:37:00,142 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 678438) isrss: 0
2025-12-23 15:37:00,143 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 678438) ixrss: 0
2025-12-23 15:37:00,143 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 678438) majflt: 0
2025-12-23 15:37:00,143 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 678438) maxrss: 596844
2025-12-23 15:37:00,143 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 678438) minflt: 52271
2025-12-23 15:37:00,144 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 678438) msgrcv: 0
2025-12-23 15:37:00,144 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 678438) msgsnd: 0
2025-12-23 15:37:00,144 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 678438) nivcsw: 128
2025-12-23 15:37:00,144 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 678438) nsignals: 0
2025-12-23 15:37:00,145 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 678438) nswap: 0
2025-12-23 15:37:00,145 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 678438) nvcsw: 481
2025-12-23 15:37:00,145 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 678438) oublock: 8
2025-12-23 15:37:00,146 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 678438) stime: 0.24861499999999997
2025-12-23 15:37:00,146 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 678438) utime: 0.507131
2025-12-23 15:37:00,146 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 678438) wtime: 0.922
2025-12-23 15:37:00,147 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 678438) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-12-23 15:37:00,147 - DEBUG - ya.test.668724  - _save_outputs: Command (pid 678438) errors:

2025-12-23 15:37:00,147 - INFO - ydb.tests.library.harness.kikimr_runner.668724  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-12-23 15:37:00,272 - INFO - ydb.tests.library.harness.kikimr_runner.668724  - __run: Cluster started and initialized
2025-12-23 15:37:00,336 - DEBUG - ydb.connection.668724  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 15:37:00,339 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.668724  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-23 15:37:00,342 - DEBUG - ydb.connection.668724  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 15:37:00,356 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.668724  - context_resolve: Resolving endpoints for database /Root
2025-12-23 15:37:00,357 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ListEndpoints, b0551108-d2cc-4777-95ca-ea095c8148e2, localhost:15967): creating call state
2025-12-23 15:37:00,358 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ListEndpoints, b0551108-d2cc-4777-95ca-ea095c8148e2, localhost:15967): request = { database: "/Root" }
2025-12-23 15:37:00,365 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ListEndpoints, b0551108-d2cc-4777-95ca-ea095c8148e2, localhost:15967): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-icmf7pzugu.auto.internal" port: 15967 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-12-23 15:37:00,366 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.668724  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-icmf7pzugu.auto.internal:15967, location 1, ssl: False>]>
2025-12-23 15:37:00,367 - DEBUG - ydb.connection.668724  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 15:37:00,381 - DEBUG - ydb.connection.668724  - close: Closing channel for endpoint localhost:15967
2025-12-23 15:37:00,384 - DEBUG - ydb.query.pool.668724  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-23 15:37:00,386 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(CreateSession, 43c64032-e7fb-474d-a032-5379946ce4c6, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:00,386 - DEBUG - ydb.connection.668724  - _log_request: RpcState(CreateSession, 43c64032-e7fb-474d-a032-5379946ce4c6, ghrun-icmf7pzugu.auto.internal:15967): request = {  }
2025-12-23 15:37:00,394 - DEBUG - ydb.connection.668724  - _log_response: RpcState(CreateSession, 43c64032-e7fb-474d-a032-5379946ce4c6, ghrun-icmf7pzugu.auto.internal:15967): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" node_id: 1 }
2025-12-23 15:37:00,395 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(AttachSession, 86381c98-13a0-4495-ba54-86ab0e3eb41b, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:00,396 - DEBUG - ydb.connection.668724  - _log_request: RpcState(AttachSession, 86381c98-13a0-4495-ba54-86ab0e3eb41b, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" }
2025-12-23 15:37:00,400 - DEBUG - ydb.connection.668724  - _log_response: RpcState(AttachSession, 86381c98-13a0-4495-ba54-86ab0e3eb41b, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:00,402 - DEBUG - ydb.query.pool.668724  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:00,403 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 565b6d3d-b212-424c-bc17-4901e121eff3, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:00,404 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 565b6d3d-b212-424c-bc17-4901e121eff3, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/off_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"off\")\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:00,406 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 565b6d3d-b212-424c-bc17-4901e121eff3, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:02,906 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:02,907 - INFO - __tests__.alter_compression.668724  - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-12-23 15:37:02,907 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:02,908 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 4d187f96-b577-4e39-950c-242113fdc378, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:02,909 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 4d187f96-b577-4e39-950c-242113fdc378, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/off_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:02,910 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 4d187f96-b577-4e39-950c-242113fdc378, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:03,890 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:03,891 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:03,891 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 115260ab-6502-4265-af33-06e30c799c31, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:03,892 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 115260ab-6502-4265-af33-06e30c799c31, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 0;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:03,894 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 115260ab-6502-4265-af33-06e30c799c31, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:04,884 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:04,885 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:04,886 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, a3fabcc1-d3e6-462a-9a05-47880a90a464, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:04,887 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, a3fabcc1-d3e6-462a-9a05-47880a90a464, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:04,888 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, a3fabcc1-d3e6-462a-9a05-47880a90a464, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:05,580 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:05,581 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:05,581 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 4b3bd618-f8c9-49c3-9f2a-2d36cefd2d73, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:05,582 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 4b3bd618-f8c9-49c3-9f2a-2d36cefd2d73, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:05,584 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 4b3bd618-f8c9-49c3-9f2a-2d36cefd2d73, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:06,851 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:06,852 - INFO - __tests__.alter_compression.668724  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 1618432, 'BlobCount': 128}}
2025-12-23 15:37:06,853 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:06,854 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 8a79d46e-bdba-4b4e-999d-8ceaabf4cd4a, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:06,855 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 8a79d46e-bdba-4b4e-999d-8ceaabf4cd4a, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 100000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:06,856 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 8a79d46e-bdba-4b4e-999d-8ceaabf4cd4a, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:07,636 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:07,637 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:07,638 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 676605dc-f6ba-414a-be46-92abbfa57aff, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:07,639 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 676605dc-f6ba-414a-be46-92abbfa57aff, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:07,640 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 676605dc-f6ba-414a-be46-92abbfa57aff, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:07,838 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:07,839 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:07,839 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, da435593-12bf-4d23-bbb0-c457571674cc, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:07,840 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, da435593-12bf-4d23-bbb0-c457571674cc, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:07,842 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, da435593-12bf-4d23-bbb0-c457571674cc, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:08,089 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:08,090 - INFO - __tests__.alter_compression.668724  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 3236864, 'BlobCount': 256}}
2025-12-23 15:37:08,090 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:08,091 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, ca05a1d4-264d-4515-9c4d-9938bfdcae58, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:08,092 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, ca05a1d4-264d-4515-9c4d-9938bfdcae58, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 200000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:08,093 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, ca05a1d4-264d-4515-9c4d-9938bfdcae58, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:08,989 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:08,990 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:08,991 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 1b572aaa-c54e-4be4-a72b-f5260a13a054, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:08,992 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 1b572aaa-c54e-4be4-a72b-f5260a13a054, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:08,993 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 1b572aaa-c54e-4be4-a72b-f5260a13a054, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:09,181 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:09,182 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:09,183 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 5f3ad43c-2554-43b7-9dd5-26fc697b37c8, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:09,184 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 5f3ad43c-2554-43b7-9dd5-26fc697b37c8, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:09,187 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 5f3ad43c-2554-43b7-9dd5-26fc697b37c8, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:09,445 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:09,446 - INFO - __tests__.alter_compression.668724  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 4855296, 'BlobCount': 384}}
2025-12-23 15:37:09,447 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:09,447 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, d8238a55-851b-41af-b044-d6c4ac9d51e8, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:09,448 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, d8238a55-851b-41af-b044-d6c4ac9d51e8, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 300000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:09,450 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, d8238a55-851b-41af-b044-d6c4ac9d51e8, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:10,248 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:10,249 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:10,250 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, ad309701-ba67-49c2-b45b-bbda501fb386, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:10,251 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, ad309701-ba67-49c2-b45b-bbda501fb386, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:10,252 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, ad309701-ba67-49c2-b45b-bbda501fb386, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:10,420 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:10,421 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:10,422 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, a1a14b62-cb12-4d83-8aad-13c2f4d0f0b0, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:10,423 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, a1a14b62-cb12-4d83-8aad-13c2f4d0f0b0, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:10,429 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, a1a14b62-cb12-4d83-8aad-13c2f4d0f0b0, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:10,710 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:10,711 - INFO - __tests__.alter_compression.668724  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 6473728, 'BlobCount': 512}}
2025-12-23 15:37:10,712 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:10,712 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 912b1aac-89ce-43fa-8bf4-6c9310a2fff5, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:10,713 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 912b1aac-89ce-43fa-8bf4-6c9310a2fff5, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 400000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:10,715 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 912b1aac-89ce-43fa-8bf4-6c9310a2fff5, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:11,500 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:11,501 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:11,502 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, f6dc0256-4095-4658-8812-e2e31c0d67b5, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:11,503 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, f6dc0256-4095-4658-8812-e2e31c0d67b5, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:11,504 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, f6dc0256-4095-4658-8812-e2e31c0d67b5, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:11,689 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:11,690 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:11,691 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 573e6bcc-7daf-422d-90ff-578a6c9292cf, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:11,692 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 573e6bcc-7daf-422d-90ff-578a6c9292cf, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:11,693 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 573e6bcc-7daf-422d-90ff-578a6c9292cf, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:12,021 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:12,021 - INFO - __tests__.alter_compression.668724  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 8092160, 'BlobCount': 640}}
2025-12-23 15:37:12,022 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:12,022 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, e6e6bf9d-cfc8-43cf-8260-d07ed1f97a6e, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:12,023 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, e6e6bf9d-cfc8-43cf-8260-d07ed1f97a6e, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 500000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:12,028 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, e6e6bf9d-cfc8-43cf-8260-d07ed1f97a6e, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:12,948 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:12,949 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:12,950 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, fce5ce90-512e-482e-80b1-319d68fc1ddf, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:12,951 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, fce5ce90-512e-482e-80b1-319d68fc1ddf, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:12,956 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, fce5ce90-512e-482e-80b1-319d68fc1ddf, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:13,173 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:13,174 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:13,174 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 95b1bf3b-e46b-4cb3-8813-97e5b9241021, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:13,175 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 95b1bf3b-e46b-4cb3-8813-97e5b9241021, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:13,180 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 95b1bf3b-e46b-4cb3-8813-97e5b9241021, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:13,610 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:13,610 - INFO - __tests__.alter_compression.668724  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 9710592, 'BlobCount': 768}}
2025-12-23 15:37:13,611 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:13,611 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, ba319fa2-b2e4-44f9-9cae-bf713b4a03c6, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:13,612 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, ba319fa2-b2e4-44f9-9cae-bf713b4a03c6, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 600000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:13,613 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, ba319fa2-b2e4-44f9-9cae-bf713b4a03c6, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:14,396 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:14,396 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:14,397 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, dd98a0cb-8fd8-44f6-b4fc-d85b12532008, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:14,398 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, dd98a0cb-8fd8-44f6-b4fc-d85b12532008, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:14,399 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, dd98a0cb-8fd8-44f6-b4fc-d85b12532008, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:14,587 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:14,588 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:14,589 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, ff6424dd-b29d-412c-8eac-8a3c377194e4, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:14,589 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, ff6424dd-b29d-412c-8eac-8a3c377194e4, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:14,591 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, ff6424dd-b29d-412c-8eac-8a3c377194e4, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:14,989 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:14,990 - INFO - __tests__.alter_compression.668724  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 11329024, 'BlobCount': 896}}
2025-12-23 15:37:14,990 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:14,991 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 3b8873b5-fb07-4e5a-a706-cbd473943e75, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:14,992 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 3b8873b5-fb07-4e5a-a706-cbd473943e75, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 700000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:14,993 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 3b8873b5-fb07-4e5a-a706-cbd473943e75, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:15,952 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:15,953 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:15,954 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 3eb052fc-8a73-4c41-ac76-438b56e04878, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:15,955 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 3eb052fc-8a73-4c41-ac76-438b56e04878, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:15,960 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 3eb052fc-8a73-4c41-ac76-438b56e04878, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:16,141 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:16,142 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:16,142 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, a90d8609-7ba1-45c6-8558-d10c96329956, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:16,143 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, a90d8609-7ba1-45c6-8558-d10c96329956, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:16,144 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, a90d8609-7ba1-45c6-8558-d10c96329956, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:16,682 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:16,683 - INFO - __tests__.alter_compression.668724  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 12947456, 'BlobCount': 1024}}
2025-12-23 15:37:16,683 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:16,684 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 0772a02f-7466-43ef-8b08-a03f06418c4c, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:16,685 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 0772a02f-7466-43ef-8b08-a03f06418c4c, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 800000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:16,689 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 0772a02f-7466-43ef-8b08-a03f06418c4c, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:17,744 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:17,745 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:17,746 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 4a13e56a-8fb2-4503-980c-69a60595f5fe, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:17,746 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 4a13e56a-8fb2-4503-980c-69a60595f5fe, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:17,748 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 4a13e56a-8fb2-4503-980c-69a60595f5fe, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:17,982 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:17,983 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:17,983 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 2183bfe7-cce1-4ff9-b8ea-4223834b8c7a, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:17,984 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 2183bfe7-cce1-4ff9-b8ea-4223834b8c7a, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:17,985 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 2183bfe7-cce1-4ff9-b8ea-4223834b8c7a, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:18,529 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:18,530 - INFO - __tests__.alter_compression.668724  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 14565888, 'BlobCount': 1152}}
2025-12-23 15:37:18,531 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:18,532 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, e8b37e8a-1e80-4ce9-85d2-7011e8f451b9, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:18,533 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, e8b37e8a-1e80-4ce9-85d2-7011e8f451b9, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 900000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:18,534 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, e8b37e8a-1e80-4ce9-85d2-7011e8f451b9, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:19,446 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:19,446 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:19,447 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 34fa2ace-0694-4602-ad57-76557a9e143c, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:19,447 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 34fa2ace-0694-4602-ad57-76557a9e143c, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:19,448 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 34fa2ace-0694-4602-ad57-76557a9e143c, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:19,681 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:19,682 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:19,682 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 279237f2-907e-4923-9127-02c005f119aa, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:19,683 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 279237f2-907e-4923-9127-02c005f119aa, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:19,685 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 279237f2-907e-4923-9127-02c005f119aa, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:20,300 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:20,301 - INFO - __tests__.alter_compression.668724  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 16184320, 'BlobCount': 1280}}
2025-12-23 15:37:20,302 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:20,302 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 01b29789-c91a-4e04-b5df-bd9fb37cfe13, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:20,303 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 01b29789-c91a-4e04-b5df-bd9fb37cfe13, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/off_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:20,305 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 01b29789-c91a-4e04-b5df-bd9fb37cfe13, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:21,353 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:21,354 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:21,355 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, b0cf1705-d1c2-47dc-a9f5-c8b7a7aeae3c, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:21,356 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, b0cf1705-d1c2-47dc-a9f5-c8b7a7aeae3c, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:21,357 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, b0cf1705-d1c2-47dc-a9f5-c8b7a7aeae3c, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:21,647 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:21,648 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:21,649 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 2359f2ef-3cd1-460b-b61c-762df3fed3ad, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:21,650 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 2359f2ef-3cd1-460b-b61c-762df3fed3ad, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:21,652 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 2359f2ef-3cd1-460b-b61c-762df3fed3ad, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:21,909 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:21,909 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:21,910 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 452d9513-44d2-4ebc-b7cb-58f649f55e29, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:21,910 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 452d9513-44d2-4ebc-b7cb-58f649f55e29, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:21,911 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 452d9513-44d2-4ebc-b7cb-58f649f55e29, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:25,728 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:35,783 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:35,784 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 1ece04d7-ec6c-4b9b-a7f9-db8496c21900, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:35,785 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 1ece04d7-ec6c-4b9b-a7f9-db8496c21900, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:35,786 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 1ece04d7-ec6c-4b9b-a7f9-db8496c21900, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:38,529 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:38,580 - INFO - root.668724  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-12-23 15:37:38,581 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:38,581 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 74c5d07b-7150-466b-b9ee-210d009a11de, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:38,582 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 74c5d07b-7150-466b-b9ee-210d009a11de, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:38,584 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 74c5d07b-7150-466b-b9ee-210d009a11de, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:41,422 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:51,473 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:51,474 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 5d9cc443-ae6e-4d9f-9c23-9eb2b22ec429, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:51,475 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 5d9cc443-ae6e-4d9f-9c23-9eb2b22ec429, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:51,476 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 5d9cc443-ae6e-4d9f-9c23-9eb2b22ec429, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:54,288 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:54,327 - INFO - root.668724  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-12-23 15:37:54,328 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:54,329 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 61c4da02-df73-41db-b411-d3e629847ee5, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:54,329 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 61c4da02-df73-41db-b411-d3e629847ee5, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:37:54,331 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 61c4da02-df73-41db-b411-d3e629847ee5, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:54,609 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:54,613 - INFO - ya.test.668724  - 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-23 15:37:54,613 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:54,614 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, c212fb48-75b3-4740-8d7c-8b1f6c2dbc85, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:54,615 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, c212fb48-75b3-4740-8d7c-8b1f6c2dbc85, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:37:54,617 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, c212fb48-75b3-4740-8d7c-8b1f6c2dbc85, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:57,332 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:57,333 - INFO - __tests__.alter_compression.668724  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_12_compression created
2025-12-23 15:37:57,334 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:57,334 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 34a50ea4-06b5-46a3-97a3-048793551d50, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:57,335 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 34a50ea4-06b5-46a3-97a3-048793551d50, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:37:57,337 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 34a50ea4-06b5-46a3-97a3-048793551d50, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:58,084 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:58,084 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:37:58,085 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, b7cef289-d0c8-4783-8638-0cb96c2d3e13, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:37:58,086 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, b7cef289-d0c8-4783-8638-0cb96c2d3e13, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:37:58,087 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, b7cef289-d0c8-4783-8638-0cb96c2d3e13, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:00,237 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:00,238 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:00,239 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, e347c5de-45c6-40a3-bbdb-34a89c0be621, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:00,240 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, e347c5de-45c6-40a3-bbdb-34a89c0be621, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:00,241 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, e347c5de-45c6-40a3-bbdb-34a89c0be621, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:01,089 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:01,090 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:01,091 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 28b05426-3fd1-46e1-8e59-f4151df6412c, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:01,092 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 28b05426-3fd1-46e1-8e59-f4151df6412c, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:01,093 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 28b05426-3fd1-46e1-8e59-f4151df6412c, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:02,716 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:02,717 - INFO - __tests__.alter_compression.668724  - 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-23 15:38:02,718 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:02,718 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 74568a62-fb82-43c2-abfe-15693cf0cb55, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:02,719 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 74568a62-fb82-43c2-abfe-15693cf0cb55, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:02,721 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 74568a62-fb82-43c2-abfe-15693cf0cb55, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:04,872 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:04,873 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:04,874 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 852ad70f-eae1-4229-9820-61bca776d3ba, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:04,875 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 852ad70f-eae1-4229-9820-61bca776d3ba, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:04,878 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 852ad70f-eae1-4229-9820-61bca776d3ba, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:05,193 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:05,194 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:05,195 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, a5f84c54-ae5d-449a-8493-d909c06c04a7, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:05,196 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, a5f84c54-ae5d-449a-8493-d909c06c04a7, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:05,198 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, a5f84c54-ae5d-449a-8493-d909c06c04a7, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:05,651 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:05,652 - INFO - __tests__.alter_compression.668724  - 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-23 15:38:05,653 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:05,653 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, aa7cb97e-6ea2-41df-8c5f-233a3c2558ff, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:05,654 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, aa7cb97e-6ea2-41df-8c5f-233a3c2558ff, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:05,656 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, aa7cb97e-6ea2-41df-8c5f-233a3c2558ff, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:07,748 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:07,749 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:07,750 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, a857d6e0-8ab3-4bbf-b956-15dc28780715, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:07,751 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, a857d6e0-8ab3-4bbf-b956-15dc28780715, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:07,753 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, a857d6e0-8ab3-4bbf-b956-15dc28780715, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:08,068 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:08,069 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:08,069 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 6d060ce6-f429-4a66-8e64-277742008e64, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:08,070 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 6d060ce6-f429-4a66-8e64-277742008e64, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:08,071 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 6d060ce6-f429-4a66-8e64-277742008e64, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:08,614 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:08,615 - INFO - __tests__.alter_compression.668724  - 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-23 15:38:08,615 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:08,616 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, a2260410-57ea-471d-a9bd-46dda82f86e0, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:08,617 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, a2260410-57ea-471d-a9bd-46dda82f86e0, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:08,618 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, a2260410-57ea-471d-a9bd-46dda82f86e0, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:11,083 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:11,084 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:11,085 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, f9ea18ba-0c1b-479e-942a-222591a0800b, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:11,086 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, f9ea18ba-0c1b-479e-942a-222591a0800b, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:11,087 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, f9ea18ba-0c1b-479e-942a-222591a0800b, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:11,373 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:11,374 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:11,375 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 6630bc41-6b93-4f92-a4ef-f09bf2ebbcfc, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:11,376 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 6630bc41-6b93-4f92-a4ef-f09bf2ebbcfc, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:11,377 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 6630bc41-6b93-4f92-a4ef-f09bf2ebbcfc, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:11,889 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:11,890 - INFO - __tests__.alter_compression.668724  - 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-23 15:38:11,890 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:11,891 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 53945784-7df1-4ac3-97bb-6832768cee25, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:11,892 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 53945784-7df1-4ac3-97bb-6832768cee25, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:11,894 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 53945784-7df1-4ac3-97bb-6832768cee25, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:12,592 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.668724  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-23 15:38:12,593 - DEBUG - ydb.connection.668724  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 10000), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-23 15:38:12,700 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.668724  - context_resolve: Resolving endpoints for database /Root
2025-12-23 15:38:12,701 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ListEndpoints, fb061630-9c7d-4b4d-a046-0ab86decaf78, localhost:15967): creating call state
2025-12-23 15:38:12,702 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ListEndpoints, fb061630-9c7d-4b4d-a046-0ab86decaf78, localhost:15967): request = { database: "/Root" }
2025-12-23 15:38:12,710 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ListEndpoints, fb061630-9c7d-4b4d-a046-0ab86decaf78, localhost:15967): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-icmf7pzugu.auto.internal" port: 15967 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-12-23 15:38:12,711 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.668724  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-icmf7pzugu.auto.internal:15967, location 1, ssl: False>]>
2025-12-23 15:38:12,712 - DEBUG - ydb.connection.668724  - close: Closing channel for endpoint localhost:15967
2025-12-23 15:38:14,319 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:14,320 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:14,321 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 19ad39b5-dd5b-46a9-8172-07a21b9e267f, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:14,322 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 19ad39b5-dd5b-46a9-8172-07a21b9e267f, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:14,323 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 19ad39b5-dd5b-46a9-8172-07a21b9e267f, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:14,606 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:14,606 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:14,607 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, b13647ac-19a5-4459-82bb-5ec69296bd98, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:14,608 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, b13647ac-19a5-4459-82bb-5ec69296bd98, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:14,609 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, b13647ac-19a5-4459-82bb-5ec69296bd98, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:15,126 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:15,126 - INFO - __tests__.alter_compression.668724  - 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-23 15:38:15,127 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:15,128 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 465a4355-5141-4d24-b4ee-f3ec4fcfe4d9, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:15,129 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 465a4355-5141-4d24-b4ee-f3ec4fcfe4d9, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:15,130 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 465a4355-5141-4d24-b4ee-f3ec4fcfe4d9, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:17,696 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:17,697 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:17,698 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, ce921242-aaa6-4dbe-a450-74e47d961c45, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:17,699 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, ce921242-aaa6-4dbe-a450-74e47d961c45, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:17,700 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, ce921242-aaa6-4dbe-a450-74e47d961c45, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:17,998 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:17,999 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:17,999 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 563a491a-d1e4-4ee5-8d3b-e2ee1ba34ec8, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:18,000 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 563a491a-d1e4-4ee5-8d3b-e2ee1ba34ec8, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:18,003 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 563a491a-d1e4-4ee5-8d3b-e2ee1ba34ec8, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:18,446 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:18,447 - INFO - __tests__.alter_compression.668724  - 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-23 15:38:18,448 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:18,448 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 378fa84e-49a2-4dbf-b789-295bac214b7b, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:18,449 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 378fa84e-49a2-4dbf-b789-295bac214b7b, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:18,451 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 378fa84e-49a2-4dbf-b789-295bac214b7b, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:20,593 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:20,594 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:20,595 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 0d51c2de-1507-4993-9492-81c50fed8bfa, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:20,596 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 0d51c2de-1507-4993-9492-81c50fed8bfa, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:20,597 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 0d51c2de-1507-4993-9492-81c50fed8bfa, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:20,886 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:20,887 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:20,888 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 3906c0a1-5c19-41fc-9ef7-8a6eebe6f74e, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:20,889 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 3906c0a1-5c19-41fc-9ef7-8a6eebe6f74e, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:20,892 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 3906c0a1-5c19-41fc-9ef7-8a6eebe6f74e, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:21,577 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:21,578 - INFO - __tests__.alter_compression.668724  - 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-23 15:38:21,578 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:21,579 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, fa6cc868-b70a-4388-afef-3ffcbbec7f75, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:21,580 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, fa6cc868-b70a-4388-afef-3ffcbbec7f75, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:21,581 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, fa6cc868-b70a-4388-afef-3ffcbbec7f75, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:23,904 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:23,905 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:23,906 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 72d78611-ae47-4deb-9549-4a9ec673de34, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:23,907 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 72d78611-ae47-4deb-9549-4a9ec673de34, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:23,908 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 72d78611-ae47-4deb-9549-4a9ec673de34, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:24,213 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:24,213 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:24,214 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, bb8b1419-10e5-44e8-bc22-06d5adfece68, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:24,215 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, bb8b1419-10e5-44e8-bc22-06d5adfece68, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:24,217 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, bb8b1419-10e5-44e8-bc22-06d5adfece68, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:24,875 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:24,876 - INFO - __tests__.alter_compression.668724  - 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-23 15:38:24,876 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:24,877 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, e3657b26-95a9-42be-be83-fdb46c0d822d, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:24,877 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, e3657b26-95a9-42be-be83-fdb46c0d822d, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:24,878 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, e3657b26-95a9-42be-be83-fdb46c0d822d, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:27,395 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:27,396 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:27,401 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 90a62664-0a5d-4964-a28c-ca62077fabe2, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:27,402 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 90a62664-0a5d-4964-a28c-ca62077fabe2, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:27,403 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 90a62664-0a5d-4964-a28c-ca62077fabe2, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:27,759 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:27,760 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:27,761 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 5931da2e-46c4-4194-85d8-53ba0b4f9c97, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:27,762 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 5931da2e-46c4-4194-85d8-53ba0b4f9c97, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:27,768 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 5931da2e-46c4-4194-85d8-53ba0b4f9c97, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:28,406 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:28,406 - INFO - __tests__.alter_compression.668724  - 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-23 15:38:28,407 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:28,408 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, a7bc5f98-1752-4e4b-bd6c-29d02bcdb8c0, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:28,409 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, a7bc5f98-1752-4e4b-bd6c-29d02bcdb8c0, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:28,410 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, a7bc5f98-1752-4e4b-bd6c-29d02bcdb8c0, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:31,131 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:31,132 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:31,133 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, f1a98557-382c-4688-b313-398566e268b9, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:31,133 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, f1a98557-382c-4688-b313-398566e268b9, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:31,135 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, f1a98557-382c-4688-b313-398566e268b9, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:31,479 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:31,480 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:31,481 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 1f0737f7-f540-4af7-aaf4-a849fa700930, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:31,482 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 1f0737f7-f540-4af7-aaf4-a849fa700930, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:31,483 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 1f0737f7-f540-4af7-aaf4-a849fa700930, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:32,234 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:32,235 - INFO - __tests__.alter_compression.668724  - 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-23 15:38:32,235 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:32,236 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 81504d64-c9e4-41da-b686-ca2656f93eda, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:32,237 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 81504d64-c9e4-41da-b686-ca2656f93eda, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:32,238 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 81504d64-c9e4-41da-b686-ca2656f93eda, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:33,271 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:33,272 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:33,273 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, a8b67475-2b94-4394-bf03-9076e68c5c9e, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:33,274 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, a8b67475-2b94-4394-bf03-9076e68c5c9e, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:33,276 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, a8b67475-2b94-4394-bf03-9076e68c5c9e, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:33,597 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:33,598 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:33,598 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, d118190a-5f54-499d-be55-3733fd7d7df5, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:33,599 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, d118190a-5f54-499d-be55-3733fd7d7df5, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:33,600 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, d118190a-5f54-499d-be55-3733fd7d7df5, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:33,923 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:33,924 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:33,925 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 9d9948be-caf7-401e-900f-9c545fe86190, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:33,925 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 9d9948be-caf7-401e-900f-9c545fe86190, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:33,926 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 9d9948be-caf7-401e-900f-9c545fe86190, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:37,354 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:47,416 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:47,417 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, fa652da9-95ce-4598-84de-0f7e76c5a2b3, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:47,418 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, fa652da9-95ce-4598-84de-0f7e76c5a2b3, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:47,419 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, fa652da9-95ce-4598-84de-0f7e76c5a2b3, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:50,355 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:50,392 - INFO - root.668724  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_12_compression`, volumes `value` (8000000, 1884808)
2025-12-23 15:38:50,393 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:50,394 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, f1c5f299-136f-41cb-a34e-e1fa6b5e4e30, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:50,395 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, f1c5f299-136f-41cb-a34e-e1fa6b5e4e30, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:50,397 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, f1c5f299-136f-41cb-a34e-e1fa6b5e4e30, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:50,608 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:50,609 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:38:50,610 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, 3bfd6b4b-112f-4d26-ae57-9e48fe2143a1, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:38:50,611 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, 3bfd6b4b-112f-4d26-ae57-9e48fe2143a1, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:38:50,612 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, 3bfd6b4b-112f-4d26-ae57-9e48fe2143a1, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:53,566 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:39:03,604 - DEBUG - ydb.query.pool.668724  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:39:03,605 - DEBUG - ydb.connection.668724  - _prepare_call: RpcState(ExecuteQuery, ca0cb6e0-e495-4107-b34a-df1c91683e40, ghrun-icmf7pzugu.auto.internal:15967): creating call state
2025-12-23 15:39:03,606 - DEBUG - ydb.connection.668724  - _log_request: RpcState(ExecuteQuery, ca0cb6e0-e495-4107-b34a-df1c91683e40, ghrun-icmf7pzugu.auto.internal:15967): request = { session_id: "ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=" 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-23 15:39:03,608 - DEBUG - ydb.connection.668724  - _log_response: RpcState(ExecuteQuery, ca0cb6e0-e495-4107-b34a-df1c91683e40, ghrun-icmf7pzugu.auto.internal:15967): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:39:05,647 - DEBUG - ydb.query.pool.668724  - release: Session returned to queue: ydb://session/3?node_id=1&id=N2Q0YzlhNjMtNjEzNTYwYmQtMWVhMTlmNDUtYjYzOTk4ZTI=
2025-12-23 15:39:05,660 - INFO - root.668724  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_12_compression`, volumes `value` (8000000, 1635952)
2025-12-23 15:39:05,661 - INFO - root.668724  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_12_compression` 8092160 / 1635952: 4.946453196670807
2025-12-23 15:39:05,663 - INFO - ya.test.668724  - pytest_runtest_teardown: Test teardown
