2025-12-23 15:37:00,025 - INFO - ya.test.676344  - pytest_runtest_setup: ####################################################################################################
2025-12-23 15:37:00,026 - INFO - ya.test.676344  - pytest_runtest_setup: test_all_supported_compression[zstd_8_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 8]
2025-12-23 15:37:00,026 - INFO - ya.test.676344  - pytest_runtest_setup: ####################################################################################################
2025-12-23 15:37:00,026 - INFO - ya.test.676344  - pytest_runtest_setup: Test setup
2025-12-23 15:37:00,029 - DEBUG - ya.test.676344  - _get_command_output_file: Command out will be placed to ydbd.out
2025-12-23 15:37:00,029 - DEBUG - ya.test.676344  - _get_command_output_file: Command err will be placed to ydbd.err
2025-12-23 15:37:00,030 - DEBUG - ya.test.676344  - execute: Executing '['/home/runner/.ya/build/build_root/wyw9/0020bd/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-23 15:37:00,037 - DEBUG - ya.test.676344  - execute: Command pid: 679084
2025-12-23 15:37:00,752 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679084) rc: 0
2025-12-23 15:37:00,753 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679084) elapsed time (sec): 0.7142865657806396
2025-12-23 15:37:00,753 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679084) idrss: 0
2025-12-23 15:37:00,754 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679084) inblock: 0
2025-12-23 15:37:00,754 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679084) isrss: 0
2025-12-23 15:37:00,754 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679084) ixrss: 0
2025-12-23 15:37:00,755 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679084) majflt: 0
2025-12-23 15:37:00,755 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679084) maxrss: 501620
2025-12-23 15:37:00,755 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679084) minflt: 45796
2025-12-23 15:37:00,755 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679084) msgrcv: 0
2025-12-23 15:37:00,756 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679084) msgsnd: 0
2025-12-23 15:37:00,756 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679084) nivcsw: 48
2025-12-23 15:37:00,756 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679084) nsignals: 0
2025-12-23 15:37:00,757 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679084) nswap: 0
2025-12-23 15:37:00,757 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679084) nvcsw: 14
2025-12-23 15:37:00,757 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679084) oublock: 8
2025-12-23 15:37:00,757 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679084) stime: 0.165043
2025-12-23 15:37:00,758 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679084) utime: 0.48145899999999997
2025-12-23 15:37:00,758 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679084) wtime: 0.722
2025-12-23 15:37:00,758 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679084) 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:37:00,759 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679084) errors:

2025-12-23 15:37:00,759 - INFO - __tests__.base.676344  - _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:37:00,891 - DEBUG - ya.test.676344  - get_binary: Binary was found by /home/runner/.ya/build/build_root/wyw9/0020bd/ydb/apps/ydbd/ydbd
2025-12-23 15:37:00,893 - DEBUG - library.python.filelock.676344  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/7557
2025-12-23 15:37:00,895 - DEBUG - ydb.tests.library.harness.kikimr_runner.676344  - start: Working directory: /home/runner/.ya/build/build_root/wyw9/0020bd/r3tmp/kikimr_cluster_gglebwja
2025-12-23 15:37:00,937 - DEBUG - ya.test.676344  - get_binary: Binary was found by /home/runner/.ya/build/build_root/wyw9/0020bd/ydb/apps/ydbd/ydbd
2025-12-23 15:37:00,938 - DEBUG - library.python.filelock.676344  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/12928
2025-12-23 15:37:00,939 - DEBUG - library.python.filelock.676344  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/2060
2025-12-23 15:37:00,939 - DEBUG - library.python.filelock.676344  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/12811
2025-12-23 15:37:00,940 - DEBUG - library.python.filelock.676344  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/3305
2025-12-23 15:37:00,941 - INFO - ydb.tests.library.harness.kikimr_runner.676344  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/wyw9/0020bd/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/kikimr_configs"
2025-12-23 15:37:00,941 - INFO - ydb.tests.library.harness.kikimr_runner.676344  - __make_run_command: Final command: /home/runner/.ya/build/build_root/wyw9/0020bd/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/0020bd/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/node_1/logfile_zo_cvbx0.log --grpc-port=12928 --mon-port=2060 --ic-port=7557
2025-12-23 15:37:00,942 - DEBUG - ydb.tests.library.harness.kikimr_runner.676344  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:12928/1, disk_size 68719476736
2025-12-23 15:37:00,942 - INFO - ydb.tests.library.harness.kikimr_runner.676344  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/wyw9/0020bd/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/kikimr_configs"
2025-12-23 15:37:00,943 - INFO - ydb.tests.library.harness.kikimr_runner.676344  - __make_run_command: Final command: /home/runner/.ya/build/build_root/wyw9/0020bd/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/0020bd/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/node_1/logfile_zo_cvbx0.log --grpc-port=12928 --mon-port=2060 --ic-port=7557
2025-12-23 15:37:00,944 - DEBUG - ya.test.676344  - execute: Executing '('/home/runner/.ya/build/build_root/wyw9/0020bd/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/wyw9/0020bd/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/wyw9/0020bd/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/node_1/logfile_zo_cvbx0.log', '--grpc-port=12928', '--mon-port=2060', '--ic-port=7557')' in '/home/runner/.ya/build/build_root/wyw9/0020bd/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/node_1' (no wait)
2025-12-23 15:37:00,947 - DEBUG - ya.test.676344  - execute: Command pid: 679804
2025-12-23 15:37:00,948 - INFO - ydb.tests.library.harness.kikimr_runner.676344  - start: Started node localhost:12928/1
2025-12-23 15:37:00,949 - DEBUG - ya.test.676344  - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-12-23 15:37:00,950 - DEBUG - ya.test.676344  - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-12-23 15:37:00,951 - DEBUG - ya.test.676344  - execute: Executing '['/home/runner/.ya/build/build_root/wyw9/0020bd/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-23 15:37:00,956 - DEBUG - ya.test.676344  - execute: Command pid: 679805
2025-12-23 15:37:01,719 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679805) rc: 0
2025-12-23 15:37:01,719 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679805) elapsed time (sec): 0.7499632835388184
2025-12-23 15:37:01,720 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679805) idrss: 0
2025-12-23 15:37:01,720 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679805) inblock: 0
2025-12-23 15:37:01,720 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679805) isrss: 0
2025-12-23 15:37:01,720 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679805) ixrss: 0
2025-12-23 15:37:01,721 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679805) majflt: 0
2025-12-23 15:37:01,721 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679805) maxrss: 507572
2025-12-23 15:37:01,721 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679805) minflt: 45836
2025-12-23 15:37:01,721 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679805) msgrcv: 0
2025-12-23 15:37:01,722 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679805) msgsnd: 0
2025-12-23 15:37:01,722 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679805) nivcsw: 115
2025-12-23 15:37:01,722 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679805) nsignals: 0
2025-12-23 15:37:01,722 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679805) nswap: 0
2025-12-23 15:37:01,722 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679805) nvcsw: 14
2025-12-23 15:37:01,723 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679805) oublock: 8
2025-12-23 15:37:01,723 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679805) stime: 0.20291599999999999
2025-12-23 15:37:01,723 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679805) utime: 0.47439499999999996
2025-12-23 15:37:01,723 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679805) wtime: 0.756
2025-12-23 15:37:01,727 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679805) 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:37:01,727 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 679805) errors:

2025-12-23 15:37:01,728 - INFO - ydb.tests.library.harness.kikimr_runner.676344  - 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:37:06,497 - DEBUG - ya.test.676344  - get_binary: Binary was found by /home/runner/.ya/build/build_root/wyw9/0020bd/ydb/apps/ydbd/ydbd
2025-12-23 15:37:06,498 - DEBUG - ydb.tests.library.harness.kikimr_runner.676344  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/wyw9/0020bd/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:12928', '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: 7557\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-12-23 15:37:06,499 - DEBUG - ya.test.676344  - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-12-23 15:37:06,500 - DEBUG - ya.test.676344  - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-12-23 15:37:06,500 - DEBUG - ya.test.676344  - execute: Executing '['/home/runner/.ya/build/build_root/wyw9/0020bd/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:12928', '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: 7557\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-12-23 15:37:06,503 - DEBUG - ya.test.676344  - execute: Command pid: 681657
2025-12-23 15:37:07,372 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681657) rc: 0
2025-12-23 15:37:07,373 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681657) elapsed time (sec): 0.8686861991882324
2025-12-23 15:37:07,373 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681657) idrss: 0
2025-12-23 15:37:07,374 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681657) inblock: 0
2025-12-23 15:37:07,374 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681657) isrss: 0
2025-12-23 15:37:07,374 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681657) ixrss: 0
2025-12-23 15:37:07,374 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681657) majflt: 0
2025-12-23 15:37:07,375 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681657) maxrss: 595976
2025-12-23 15:37:07,375 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681657) minflt: 52192
2025-12-23 15:37:07,375 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681657) msgrcv: 0
2025-12-23 15:37:07,376 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681657) msgsnd: 0
2025-12-23 15:37:07,376 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681657) nivcsw: 85
2025-12-23 15:37:07,376 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681657) nsignals: 0
2025-12-23 15:37:07,376 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681657) nswap: 0
2025-12-23 15:37:07,377 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681657) nvcsw: 759
2025-12-23 15:37:07,377 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681657) oublock: 8
2025-12-23 15:37:07,377 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681657) stime: 0.277918
2025-12-23 15:37:07,378 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681657) utime: 0.529361
2025-12-23 15:37:07,378 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681657) wtime: 0.872
2025-12-23 15:37:07,378 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681657) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-12-23 15:37:07,378 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681657) errors:

2025-12-23 15:37:07,388 - DEBUG - ya.test.676344  - get_binary: Binary was found by /home/runner/.ya/build/build_root/wyw9/0020bd/ydb/apps/ydbd/ydbd
2025-12-23 15:37:07,389 - DEBUG - ydb.tests.library.harness.kikimr_runner.676344  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/wyw9/0020bd/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:12928', '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:37:07,390 - DEBUG - ya.test.676344  - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-12-23 15:37:07,391 - DEBUG - ya.test.676344  - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-12-23 15:37:07,391 - DEBUG - ya.test.676344  - execute: Executing '['/home/runner/.ya/build/build_root/wyw9/0020bd/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:12928', '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:37:07,393 - DEBUG - ya.test.676344  - execute: Command pid: 681931
2025-12-23 15:37:08,320 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681931) rc: 0
2025-12-23 15:37:08,321 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681931) elapsed time (sec): 0.9262259006500244
2025-12-23 15:37:08,321 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681931) idrss: 0
2025-12-23 15:37:08,322 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681931) inblock: 0
2025-12-23 15:37:08,322 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681931) isrss: 0
2025-12-23 15:37:08,322 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681931) ixrss: 0
2025-12-23 15:37:08,323 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681931) majflt: 0
2025-12-23 15:37:08,323 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681931) maxrss: 595976
2025-12-23 15:37:08,323 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681931) minflt: 52299
2025-12-23 15:37:08,323 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681931) msgrcv: 0
2025-12-23 15:37:08,324 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681931) msgsnd: 0
2025-12-23 15:37:08,324 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681931) nivcsw: 135
2025-12-23 15:37:08,324 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681931) nsignals: 0
2025-12-23 15:37:08,325 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681931) nswap: 0
2025-12-23 15:37:08,325 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681931) nvcsw: 683
2025-12-23 15:37:08,325 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681931) oublock: 8
2025-12-23 15:37:08,325 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681931) stime: 0.316569
2025-12-23 15:37:08,326 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681931) utime: 0.534818
2025-12-23 15:37:08,326 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681931) wtime: 0.928
2025-12-23 15:37:08,326 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681931) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-12-23 15:37:08,327 - DEBUG - ya.test.676344  - _save_outputs: Command (pid 681931) errors:

2025-12-23 15:37:08,327 - INFO - ydb.tests.library.harness.kikimr_runner.676344  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-12-23 15:37:08,429 - INFO - ydb.tests.library.harness.kikimr_runner.676344  - __run: Cluster started and initialized
2025-12-23 15:37:08,459 - DEBUG - ydb.connection.676344  - 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:08,462 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.676344  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-23 15:37:08,465 - DEBUG - ydb.connection.676344  - 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:08,480 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.676344  - context_resolve: Resolving endpoints for database /Root
2025-12-23 15:37:08,481 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ListEndpoints, 462d09af-f60a-4827-9044-7fe0620444b8, localhost:12928): creating call state
2025-12-23 15:37:08,482 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ListEndpoints, 462d09af-f60a-4827-9044-7fe0620444b8, localhost:12928): request = { database: "/Root" }
2025-12-23 15:37:08,491 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ListEndpoints, 462d09af-f60a-4827-9044-7fe0620444b8, localhost:12928): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-icmf7pzugu.auto.internal" port: 12928 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:08,492 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.676344  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-icmf7pzugu.auto.internal:12928, location 1, ssl: False>]>
2025-12-23 15:37:08,492 - DEBUG - ydb.connection.676344  - 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:08,509 - DEBUG - ydb.connection.676344  - close: Closing channel for endpoint localhost:12928
2025-12-23 15:37:08,511 - DEBUG - ydb.query.pool.676344  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-23 15:37:08,512 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(CreateSession, e88e528a-1396-4fc2-8777-00bb645604fa, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:08,512 - DEBUG - ydb.connection.676344  - _log_request: RpcState(CreateSession, e88e528a-1396-4fc2-8777-00bb645604fa, ghrun-icmf7pzugu.auto.internal:12928): request = {  }
2025-12-23 15:37:08,519 - DEBUG - ydb.connection.676344  - _log_response: RpcState(CreateSession, e88e528a-1396-4fc2-8777-00bb645604fa, ghrun-icmf7pzugu.auto.internal:12928): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" node_id: 1 }
2025-12-23 15:37:08,520 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(AttachSession, d13bcf1e-b2f4-4318-8158-ae158a6eb0d4, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:08,521 - DEBUG - ydb.connection.676344  - _log_request: RpcState(AttachSession, d13bcf1e-b2f4-4318-8158-ae158a6eb0d4, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" }
2025-12-23 15:37:08,525 - DEBUG - ydb.connection.676344  - _log_response: RpcState(AttachSession, d13bcf1e-b2f4-4318-8158-ae158a6eb0d4, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:08,527 - DEBUG - ydb.query.pool.676344  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:08,528 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 39f9b0a2-80d5-4a0b-842c-924682500b88, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:08,529 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 39f9b0a2-80d5-4a0b-842c-924682500b88, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:08,530 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 39f9b0a2-80d5-4a0b-842c-924682500b88, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:10,561 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:10,562 - INFO - __tests__.alter_compression.676344  - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-12-23 15:37:10,562 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:10,563 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 7af05376-69d6-41e4-ad6c-61669461d5e6, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:10,564 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 7af05376-69d6-41e4-ad6c-61669461d5e6, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:10,565 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 7af05376-69d6-41e4-ad6c-61669461d5e6, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:11,357 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:11,357 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:11,358 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 1720f2d6-c678-4749-aede-5b6069eb6559, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:11,359 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 1720f2d6-c678-4749-aede-5b6069eb6559, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:11,360 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 1720f2d6-c678-4749-aede-5b6069eb6559, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:12,258 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:12,258 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:12,259 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, b77ea3ed-856e-41ab-9541-e0f1743a15ff, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:12,260 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, b77ea3ed-856e-41ab-9541-e0f1743a15ff, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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,261 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, b77ea3ed-856e-41ab-9541-e0f1743a15ff, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:12,981 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:12,982 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:12,982 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, bee1381a-469a-4d81-a28c-9a2f625650c9, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:12,983 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, bee1381a-469a-4d81-a28c-9a2f625650c9, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:12,985 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, bee1381a-469a-4d81-a28c-9a2f625650c9, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:14,243 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:14,244 - INFO - __tests__.alter_compression.676344  - 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:14,245 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:14,245 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 5f283ee5-88ae-4bb9-b9de-157280dda7a4, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:14,246 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 5f283ee5-88ae-4bb9-b9de-157280dda7a4, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:14,248 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 5f283ee5-88ae-4bb9-b9de-157280dda7a4, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:15,091 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:15,092 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:15,093 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 461b11d8-4a79-41e9-b52c-be40564f0f9a, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:15,093 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 461b11d8-4a79-41e9-b52c-be40564f0f9a, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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,094 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 461b11d8-4a79-41e9-b52c-be40564f0f9a, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:15,308 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:15,309 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:15,310 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, f024a3d2-cbd9-4220-8b83-37b803140736, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:15,311 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, f024a3d2-cbd9-4220-8b83-37b803140736, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:15,313 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, f024a3d2-cbd9-4220-8b83-37b803140736, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:15,644 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:15,645 - INFO - __tests__.alter_compression.676344  - 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:15,645 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:15,646 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 8233e1ed-f488-4569-8c0e-bcff8f893810, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:15,647 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 8233e1ed-f488-4569-8c0e-bcff8f893810, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:15,649 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 8233e1ed-f488-4569-8c0e-bcff8f893810, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:16,640 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:16,640 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:16,641 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, f16177c4-7813-43df-a98d-98449a6c7616, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:16,642 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, f16177c4-7813-43df-a98d-98449a6c7616, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:16,644 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, f16177c4-7813-43df-a98d-98449a6c7616, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:16,849 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:16,849 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:16,850 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 01877bfa-70c7-4e86-86dc-ad1b7ee0387e, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:16,851 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 01877bfa-70c7-4e86-86dc-ad1b7ee0387e, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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,853 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 01877bfa-70c7-4e86-86dc-ad1b7ee0387e, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:17,174 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:17,175 - INFO - __tests__.alter_compression.676344  - 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:17,176 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:17,177 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 4396b4ac-61c3-4314-8464-71df72ec5f2c, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:17,178 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 4396b4ac-61c3-4314-8464-71df72ec5f2c, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:17,180 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 4396b4ac-61c3-4314-8464-71df72ec5f2c, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:18,177 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:18,178 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:18,179 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 89c142c9-d6e8-48a7-b6af-1916b8e404d5, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:18,180 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 89c142c9-d6e8-48a7-b6af-1916b8e404d5, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:18,181 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 89c142c9-d6e8-48a7-b6af-1916b8e404d5, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:18,427 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:18,428 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:18,429 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 385d5686-096e-4706-96ee-73f78c9c36c7, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:18,430 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 385d5686-096e-4706-96ee-73f78c9c36c7, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:18,432 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 385d5686-096e-4706-96ee-73f78c9c36c7, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:18,895 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:18,896 - INFO - __tests__.alter_compression.676344  - 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:18,897 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:18,898 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 671d70cd-5edf-4f75-ad9a-1087647b4d07, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:18,899 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 671d70cd-5edf-4f75-ad9a-1087647b4d07, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:18,901 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 671d70cd-5edf-4f75-ad9a-1087647b4d07, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:20,008 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:20,009 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:20,010 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, a772e965-d613-4d46-be6b-ce6ab1d80a09, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:20,011 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, a772e965-d613-4d46-be6b-ce6ab1d80a09, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:20,012 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, a772e965-d613-4d46-be6b-ce6ab1d80a09, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:20,256 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:20,257 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:20,257 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, b243260b-40b1-48bf-987c-d285a6a9fd6c, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:20,258 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, b243260b-40b1-48bf-987c-d285a6a9fd6c, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:20,259 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, b243260b-40b1-48bf-987c-d285a6a9fd6c, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:20,805 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:20,805 - INFO - __tests__.alter_compression.676344  - 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:20,805 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:20,806 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 89a5c161-82a5-423e-bc47-13ce3e555247, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:20,806 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 89a5c161-82a5-423e-bc47-13ce3e555247, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:20,807 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 89a5c161-82a5-423e-bc47-13ce3e555247, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:21,753 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:21,754 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:21,754 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, e01e1d33-a6bf-4237-9ba1-863ccce68d7d, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:21,755 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, e01e1d33-a6bf-4237-9ba1-863ccce68d7d, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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,756 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, e01e1d33-a6bf-4237-9ba1-863ccce68d7d, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:22,059 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:22,059 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:22,060 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, c96ab0e8-eb66-46dc-b196-85d0837daefb, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:22,061 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, c96ab0e8-eb66-46dc-b196-85d0837daefb, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:22,062 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, c96ab0e8-eb66-46dc-b196-85d0837daefb, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:22,502 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:22,502 - INFO - __tests__.alter_compression.676344  - 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:22,503 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:22,503 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 7e7a2caf-e412-475b-8c61-a85f78311757, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:22,504 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 7e7a2caf-e412-475b-8c61-a85f78311757, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:22,505 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 7e7a2caf-e412-475b-8c61-a85f78311757, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:23,547 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:23,548 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:23,548 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 05201c2b-f0a4-405c-aba8-e72ed24092d6, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:23,549 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 05201c2b-f0a4-405c-aba8-e72ed24092d6, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:23,550 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 05201c2b-f0a4-405c-aba8-e72ed24092d6, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:23,777 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:23,778 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:23,779 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 09f313c4-abd4-4b17-9058-7099ee795ed2, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:23,780 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 09f313c4-abd4-4b17-9058-7099ee795ed2, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:23,781 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 09f313c4-abd4-4b17-9058-7099ee795ed2, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:24,264 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:24,265 - INFO - __tests__.alter_compression.676344  - 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:24,265 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:24,266 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 8f809044-83c9-4069-ac2f-6ea356f6e776, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:24,267 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 8f809044-83c9-4069-ac2f-6ea356f6e776, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:24,268 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 8f809044-83c9-4069-ac2f-6ea356f6e776, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:25,352 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:25,353 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:25,354 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, fb328cb9-64d6-45be-a488-ed4b1d44e605, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:25,354 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, fb328cb9-64d6-45be-a488-ed4b1d44e605, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:25,356 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, fb328cb9-64d6-45be-a488-ed4b1d44e605, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:25,604 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:25,605 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:25,606 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 73dde918-372b-4128-ac96-9bcaa2ad50d2, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:25,607 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 73dde918-372b-4128-ac96-9bcaa2ad50d2, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:25,609 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 73dde918-372b-4128-ac96-9bcaa2ad50d2, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:26,146 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:26,147 - INFO - __tests__.alter_compression.676344  - 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:26,147 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:26,148 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, b62d1259-f8fd-43c5-9d67-e1d71066fb4a, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:26,149 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, b62d1259-f8fd-43c5-9d67-e1d71066fb4a, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:26,150 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, b62d1259-f8fd-43c5-9d67-e1d71066fb4a, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:27,260 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:27,261 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:27,262 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, cf2cab86-c59f-4ec1-a54f-dd85bb78ac5b, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:27,263 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, cf2cab86-c59f-4ec1-a54f-dd85bb78ac5b, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:27,265 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, cf2cab86-c59f-4ec1-a54f-dd85bb78ac5b, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:27,541 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:27,542 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:27,543 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 84e4f3ba-d7d2-4b35-8556-b2549cb07918, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:27,543 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 84e4f3ba-d7d2-4b35-8556-b2549cb07918, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:27,545 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 84e4f3ba-d7d2-4b35-8556-b2549cb07918, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:28,152 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:28,152 - INFO - __tests__.alter_compression.676344  - 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:28,153 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:28,154 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 019eaa37-0f40-4705-8df2-335f774684df, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:28,155 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 019eaa37-0f40-4705-8df2-335f774684df, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:28,157 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 019eaa37-0f40-4705-8df2-335f774684df, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:29,177 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:29,178 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:29,179 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, c0fe27bb-ae23-4aae-9a10-25e3e99736af, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:29,180 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, c0fe27bb-ae23-4aae-9a10-25e3e99736af, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:29,181 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, c0fe27bb-ae23-4aae-9a10-25e3e99736af, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:29,462 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:29,463 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:29,464 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 622f8a18-6902-48b7-9447-2a3f718bdde7, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:29,465 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 622f8a18-6902-48b7-9447-2a3f718bdde7, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:29,466 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 622f8a18-6902-48b7-9447-2a3f718bdde7, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:30,085 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:30,085 - INFO - __tests__.alter_compression.676344  - 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:30,086 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:30,087 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, ba974c86-1b17-48f9-996d-7bdaf5c501e8, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:30,088 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, ba974c86-1b17-48f9-996d-7bdaf5c501e8, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:30,089 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, ba974c86-1b17-48f9-996d-7bdaf5c501e8, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:31,043 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:31,043 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:31,044 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, fde3aff5-21d3-4aea-8fac-e730dcc0b91c, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:31,045 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, fde3aff5-21d3-4aea-8fac-e730dcc0b91c, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:31,047 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, fde3aff5-21d3-4aea-8fac-e730dcc0b91c, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:31,230 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:31,231 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:31,232 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 9f5ca679-b65f-4d1d-ba23-51b3b5d1fbf1, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:31,233 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 9f5ca679-b65f-4d1d-ba23-51b3b5d1fbf1, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:31,234 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 9f5ca679-b65f-4d1d-ba23-51b3b5d1fbf1, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:31,468 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:31,468 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:31,469 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, e4d1108a-9232-4471-b185-d5f04e3128ae, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:31,470 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, e4d1108a-9232-4471-b185-d5f04e3128ae, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:31,471 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, e4d1108a-9232-4471-b185-d5f04e3128ae, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:34,613 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:44,652 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:44,653 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 123d9d6f-28b0-4052-a264-debeee6ac385, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:44,655 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 123d9d6f-28b0-4052-a264-debeee6ac385, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:44,656 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 123d9d6f-28b0-4052-a264-debeee6ac385, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:47,204 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:47,240 - INFO - root.676344  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-12-23 15:37:47,241 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:37:47,241 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 454e910c-9eb3-4bf6-aecf-44c12663caba, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:37:47,242 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 454e910c-9eb3-4bf6-aecf-44c12663caba, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:47,243 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 454e910c-9eb3-4bf6-aecf-44c12663caba, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:37:50,009 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:00,058 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:00,059 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 8050c080-598e-4a4f-b848-72847b6f63c8, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:00,060 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 8050c080-598e-4a4f-b848-72847b6f63c8, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:38:00,061 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 8050c080-598e-4a4f-b848-72847b6f63c8, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:02,960 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:02,998 - INFO - root.676344  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-12-23 15:38:02,999 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:03,000 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 3ddf0067-f545-43ab-bc11-d42099f2f3ce, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:03,001 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 3ddf0067-f545-43ab-bc11-d42099f2f3ce, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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:38:03,003 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 3ddf0067-f545-43ab-bc11-d42099f2f3ce, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:03,300 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:03,303 - INFO - ya.test.676344  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_8_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 8])
2025-12-23 15:38:03,304 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:03,305 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 4ba57dfe-fc25-43ba-8498-d22d370f93f5, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:03,306 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 4ba57dfe-fc25-43ba-8498-d22d370f93f5, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_8_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 8)\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:38:03,307 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 4ba57dfe-fc25-43ba-8498-d22d370f93f5, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:05,781 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:05,782 - INFO - __tests__.alter_compression.676344  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_8_compression created
2025-12-23 15:38:05,783 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:05,783 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 39a895b8-5a07-4de6-be43-5cd73c2d38c6, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:05,784 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 39a895b8-5a07-4de6-be43-5cd73c2d38c6, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_8_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:05,786 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 39a895b8-5a07-4de6-be43-5cd73c2d38c6, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:06,610 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:06,610 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:06,611 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, c9c0c5ae-af6b-4ad6-9e6a-3e00a42a0297, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:06,612 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, c9c0c5ae-af6b-4ad6-9e6a-3e00a42a0297, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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:06,614 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, c9c0c5ae-af6b-4ad6-9e6a-3e00a42a0297, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:08,562 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:08,563 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:08,564 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, f7126b47-7248-4293-b3d4-f59fa2b7e0b0, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:08,564 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, f7126b47-7248-4293-b3d4-f59fa2b7e0b0, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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:08,566 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, f7126b47-7248-4293-b3d4-f59fa2b7e0b0, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:09,437 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:09,438 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:09,439 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 9d1f1948-c96c-46df-be0f-72db489abda5, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:09,440 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 9d1f1948-c96c-46df-be0f-72db489abda5, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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:09,441 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 9d1f1948-c96c-46df-be0f-72db489abda5, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:11,297 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:11,298 - INFO - __tests__.alter_compression.676344  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318016, 'BlobCount': 128}}
2025-12-23 15:38:11,298 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:11,299 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, d88060d6-fb75-4eb1-96b0-9ff11c9d9c34, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:11,300 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, d88060d6-fb75-4eb1-96b0-9ff11c9d9c34, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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,302 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, d88060d6-fb75-4eb1-96b0-9ff11c9d9c34, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:13,441 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:13,442 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:13,443 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, cbb567ba-b813-4bbe-974a-172f66be1bd1, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:13,444 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, cbb567ba-b813-4bbe-974a-172f66be1bd1, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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:13,445 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, cbb567ba-b813-4bbe-974a-172f66be1bd1, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:13,810 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:13,812 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:13,813 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 33893286-fa69-4257-bca8-84a9f53fe0c7, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:13,814 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 33893286-fa69-4257-bca8-84a9f53fe0c7, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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:13,816 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 33893286-fa69-4257-bca8-84a9f53fe0c7, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:14,289 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:14,289 - INFO - __tests__.alter_compression.676344  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 637312, 'BlobCount': 256}}
2025-12-23 15:38:14,290 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:14,290 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 407e9531-d01c-4af6-be9e-30db6db79639, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:14,291 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 407e9531-d01c-4af6-be9e-30db6db79639, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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:14,293 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 407e9531-d01c-4af6-be9e-30db6db79639, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:16,355 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:16,356 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:16,356 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 10b01fac-c465-49de-9a50-9f5ce049f2b1, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:16,357 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 10b01fac-c465-49de-9a50-9f5ce049f2b1, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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:16,359 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 10b01fac-c465-49de-9a50-9f5ce049f2b1, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:16,708 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:16,708 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:16,709 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, c00cb56a-b819-4514-ba67-49b3b975528a, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:16,710 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, c00cb56a-b819-4514-ba67-49b3b975528a, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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:16,711 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, c00cb56a-b819-4514-ba67-49b3b975528a, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:17,230 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:17,230 - INFO - __tests__.alter_compression.676344  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 956352, 'BlobCount': 384}}
2025-12-23 15:38:17,231 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:17,231 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, b16dbda4-96fb-4a09-abf5-240d10e6b0db, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:17,232 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, b16dbda4-96fb-4a09-abf5-240d10e6b0db, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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:17,234 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, b16dbda4-96fb-4a09-abf5-240d10e6b0db, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:19,012 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:19,013 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:19,014 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, df89ad90-98e3-4102-877e-e4e1d1bf4a87, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:19,015 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, df89ad90-98e3-4102-877e-e4e1d1bf4a87, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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:19,016 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, df89ad90-98e3-4102-877e-e4e1d1bf4a87, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:19,283 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:19,284 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:19,284 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 385a44ea-4ea6-458d-9481-1896e64b3336, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:19,285 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 385a44ea-4ea6-458d-9481-1896e64b3336, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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:19,286 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 385a44ea-4ea6-458d-9481-1896e64b3336, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:19,684 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:19,701 - INFO - __tests__.alter_compression.676344  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1275712, 'BlobCount': 512}}
2025-12-23 15:38:19,702 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:19,702 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 094a8730-f3df-4d93-a436-b1f73ee0d8eb, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:19,703 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 094a8730-f3df-4d93-a436-b1f73ee0d8eb, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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:19,704 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 094a8730-f3df-4d93-a436-b1f73ee0d8eb, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:21,518 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:21,519 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:21,519 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, f5038991-ba13-4a42-a060-1b43b77b2dff, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:21,520 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, f5038991-ba13-4a42-a060-1b43b77b2dff, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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:21,522 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, f5038991-ba13-4a42-a060-1b43b77b2dff, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:21,797 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:21,798 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:21,799 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 9d99e2f0-9adc-4dec-a9ff-dd607830e258, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:21,800 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 9d99e2f0-9adc-4dec-a9ff-dd607830e258, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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:21,808 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 9d99e2f0-9adc-4dec-a9ff-dd607830e258, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:22,261 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:22,262 - INFO - __tests__.alter_compression.676344  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1594672, 'BlobCount': 640}}
2025-12-23 15:38:22,262 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:22,263 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 96204460-d437-4f2e-bed2-87484e8fb9c0, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:22,264 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 96204460-d437-4f2e-bed2-87484e8fb9c0, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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:22,265 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 96204460-d437-4f2e-bed2-87484e8fb9c0, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:24,145 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:24,146 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:24,147 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, b4d4d9cb-d3bc-4bc8-866b-3cd88a05cd5f, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:24,148 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, b4d4d9cb-d3bc-4bc8-866b-3cd88a05cd5f, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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:24,153 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, b4d4d9cb-d3bc-4bc8-866b-3cd88a05cd5f, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:24,472 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:24,473 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:24,473 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 2570cdf3-4caf-4b78-9430-f0a363b20782, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:24,474 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 2570cdf3-4caf-4b78-9430-f0a363b20782, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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,476 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 2570cdf3-4caf-4b78-9430-f0a363b20782, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:25,174 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:25,174 - INFO - __tests__.alter_compression.676344  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1913856, 'BlobCount': 768}}
2025-12-23 15:38:25,175 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:25,176 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 56617475-edb6-4105-88ec-c69cc042f1bd, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:25,177 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 56617475-edb6-4105-88ec-c69cc042f1bd, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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:25,185 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 56617475-edb6-4105-88ec-c69cc042f1bd, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:27,221 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:27,222 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:27,223 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 23f46476-2148-4db0-a87d-ec3e7eb53836, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:27,224 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 23f46476-2148-4db0-a87d-ec3e7eb53836, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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,225 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 23f46476-2148-4db0-a87d-ec3e7eb53836, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:27,620 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:27,621 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:27,622 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 340548ee-0ff9-413d-8777-c0f253cda320, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:27,623 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 340548ee-0ff9-413d-8777-c0f253cda320, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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,624 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 340548ee-0ff9-413d-8777-c0f253cda320, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:28,217 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:28,217 - INFO - __tests__.alter_compression.676344  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2232992, 'BlobCount': 896}}
2025-12-23 15:38:28,218 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:28,219 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 00095ec9-a83c-48ff-8e07-42fe6379c823, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:28,220 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 00095ec9-a83c-48ff-8e07-42fe6379c823, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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,221 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 00095ec9-a83c-48ff-8e07-42fe6379c823, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:30,007 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:30,007 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:30,008 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 38d5ca91-935b-4023-b11e-5b07402e1ce5, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:30,009 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 38d5ca91-935b-4023-b11e-5b07402e1ce5, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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:30,010 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 38d5ca91-935b-4023-b11e-5b07402e1ce5, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:30,317 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:30,318 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:30,319 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 41481bdc-8919-4f42-af1e-40b64dae75a0, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:30,319 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 41481bdc-8919-4f42-af1e-40b64dae75a0, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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:30,321 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 41481bdc-8919-4f42-af1e-40b64dae75a0, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:30,925 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:30,925 - INFO - __tests__.alter_compression.676344  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2552480, 'BlobCount': 1024}}
2025-12-23 15:38:30,926 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:30,927 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 45a78428-2fc7-4634-972b-8be559371af3, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:30,928 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 45a78428-2fc7-4634-972b-8be559371af3, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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:30,929 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 45a78428-2fc7-4634-972b-8be559371af3, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:32,739 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:32,739 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:32,740 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, e2c4cc8f-6cb1-4021-befa-48b19e901814, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:32,741 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, e2c4cc8f-6cb1-4021-befa-48b19e901814, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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:32,742 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, e2c4cc8f-6cb1-4021-befa-48b19e901814, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:33,024 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:33,025 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:33,026 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 82a9b742-41ce-4cc7-abf9-0987450660b7, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:33,026 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 82a9b742-41ce-4cc7-abf9-0987450660b7, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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:33,028 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 82a9b742-41ce-4cc7-abf9-0987450660b7, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:33,699 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:33,700 - INFO - __tests__.alter_compression.676344  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2871488, 'BlobCount': 1152}}
2025-12-23 15:38:33,700 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:33,701 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, ecf4e615-73b2-41e3-8069-18d4dadbdaab, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:33,702 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, ecf4e615-73b2-41e3-8069-18d4dadbdaab, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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:33,705 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, ecf4e615-73b2-41e3-8069-18d4dadbdaab, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:35,027 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.676344  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-23 15:38:35,028 - DEBUG - ydb.connection.676344  - 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:35,040 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.676344  - context_resolve: Resolving endpoints for database /Root
2025-12-23 15:38:35,041 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ListEndpoints, 09419650-8f9b-443c-a36e-17883d84cf03, localhost:12928): creating call state
2025-12-23 15:38:35,042 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ListEndpoints, 09419650-8f9b-443c-a36e-17883d84cf03, localhost:12928): request = { database: "/Root" }
2025-12-23 15:38:35,050 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ListEndpoints, 09419650-8f9b-443c-a36e-17883d84cf03, localhost:12928): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-icmf7pzugu.auto.internal" port: 12928 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:35,051 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.676344  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-icmf7pzugu.auto.internal:12928, location 1, ssl: False>]>
2025-12-23 15:38:35,051 - DEBUG - ydb.connection.676344  - close: Closing channel for endpoint localhost:12928
2025-12-23 15:38:35,520 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:35,521 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:35,522 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 4bebd4f5-8507-442b-a196-7c4c1aa894ba, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:35,523 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 4bebd4f5-8507-442b-a196-7c4c1aa894ba, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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:35,524 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 4bebd4f5-8507-442b-a196-7c4c1aa894ba, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:35,761 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:35,762 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:35,762 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, e2f5ca2d-f439-4a58-aae7-3edcc72a18f1, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:35,763 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, e2f5ca2d-f439-4a58-aae7-3edcc72a18f1, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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:35,769 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, e2f5ca2d-f439-4a58-aae7-3edcc72a18f1, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:36,565 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:36,566 - INFO - __tests__.alter_compression.676344  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3190992, 'BlobCount': 1280}}
2025-12-23 15:38:36,566 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:36,567 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, efd01e0c-238c-41ae-bc05-0e248a00b60c, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:36,568 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, efd01e0c-238c-41ae-bc05-0e248a00b60c, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_8_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-23 15:38:36,569 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, efd01e0c-238c-41ae-bc05-0e248a00b60c, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:37,531 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:37,532 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:37,533 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 536035e3-11e8-4fcf-aa17-3802700d358b, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:37,534 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 536035e3-11e8-4fcf-aa17-3802700d358b, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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:37,536 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 536035e3-11e8-4fcf-aa17-3802700d358b, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:37,760 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:37,761 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:37,762 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 5bc98bf2-93bc-4342-a1f0-2fb91afb8fee, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:37,763 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 5bc98bf2-93bc-4342-a1f0-2fb91afb8fee, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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:37,765 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 5bc98bf2-93bc-4342-a1f0-2fb91afb8fee, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:38,051 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:38,052 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:38,053 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 4a33d761-551e-4949-907e-85c514028637, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:38,054 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 4a33d761-551e-4949-907e-85c514028637, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_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:38,055 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 4a33d761-551e-4949-907e-85c514028637, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:41,244 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:51,305 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:51,306 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, ebbaa2fd-2e43-4a2d-bfd7-d19af983d646, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:51,307 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, ebbaa2fd-2e43-4a2d-bfd7-d19af983d646, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_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:51,308 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, ebbaa2fd-2e43-4a2d-bfd7-d19af983d646, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:54,059 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:54,090 - INFO - root.676344  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_8_compression`, volumes `value` (8000000, 1595496)
2025-12-23 15:38:54,091 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:54,092 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 449d168c-db65-4b77-940a-1ae6f109a66d, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:54,093 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 449d168c-db65-4b77-940a-1ae6f109a66d, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" 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_8_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:54,094 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 449d168c-db65-4b77-940a-1ae6f109a66d, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:54,333 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:54,334 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:38:54,335 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, de78e1d1-d162-4836-9721-83830b2d608b, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:38:54,336 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, de78e1d1-d162-4836-9721-83830b2d608b, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_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:54,337 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, de78e1d1-d162-4836-9721-83830b2d608b, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:38:57,551 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:39:07,589 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:39:07,590 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 55c2b729-7c46-4371-8b53-6bbc1b7a7c40, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:39:07,591 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 55c2b729-7c46-4371-8b53-6bbc1b7a7c40, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_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:07,592 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 55c2b729-7c46-4371-8b53-6bbc1b7a7c40, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:39:10,519 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:39:20,544 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:39:20,545 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, 17e45e4f-b4fb-4a5b-b69d-e4fe698505d3, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:39:20,546 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, 17e45e4f-b4fb-4a5b-b69d-e4fe698505d3, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_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:20,547 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, 17e45e4f-b4fb-4a5b-b69d-e4fe698505d3, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:39:21,331 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:39:31,336 - DEBUG - ydb.query.pool.676344  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:39:31,337 - DEBUG - ydb.connection.676344  - _prepare_call: RpcState(ExecuteQuery, c84088a3-e0fe-48ad-86a5-1df6e768ca9a, ghrun-icmf7pzugu.auto.internal:12928): creating call state
2025-12-23 15:39:31,338 - DEBUG - ydb.connection.676344  - _log_request: RpcState(ExecuteQuery, c84088a3-e0fe-48ad-86a5-1df6e768ca9a, ghrun-icmf7pzugu.auto.internal:12928): request = { session_id: "ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_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:31,339 - DEBUG - ydb.connection.676344  - _log_response: RpcState(ExecuteQuery, c84088a3-e0fe-48ad-86a5-1df6e768ca9a, ghrun-icmf7pzugu.auto.internal:12928): response = { <_MultiThreadedRendezvous object> }
2025-12-23 15:39:32,106 - DEBUG - ydb.query.pool.676344  - release: Session returned to queue: ydb://session/3?node_id=1&id=NDA2M2M2NGQtNzIxMWE4MTQtNGY0YjMwZjAtNWI1YTFmMGY=
2025-12-23 15:39:32,110 - INFO - root.676344  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_8_compression`, volumes `value` (8000000, 1465240)
2025-12-23 15:39:32,110 - INFO - root.676344  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_8_compression` 8092160 / 1465240: 5.522753951571073
2025-12-23 15:39:32,113 - INFO - ya.test.676344  - pytest_runtest_teardown: Test teardown
