2025-11-21 17:36:54,282 - INFO - ya.test.673571  - pytest_runtest_setup: ####################################################################################################
2025-11-21 17:36:54,282 - INFO - ya.test.673571  - pytest_runtest_setup: test_all_supported_compression[zstd_20_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 20]
2025-11-21 17:36:54,283 - INFO - ya.test.673571  - pytest_runtest_setup: ####################################################################################################
2025-11-21 17:36:54,283 - INFO - ya.test.673571  - pytest_runtest_setup: Test setup
2025-11-21 17:36:54,285 - DEBUG - ya.test.673571  - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-21 17:36:54,286 - DEBUG - ya.test.673571  - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-21 17:36:54,287 - DEBUG - ya.test.673571  - execute: Executing '['/home/runner/.ya/build/build_root/ue5z/0055a5/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-21 17:36:54,300 - DEBUG - ya.test.673571  - execute: Command pid: 674474
2025-11-21 17:36:55,321 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674474) rc: 0
2025-11-21 17:36:55,322 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674474) elapsed time (sec): 1.0202882289886475
2025-11-21 17:36:55,323 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674474) idrss: 0
2025-11-21 17:36:55,323 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674474) inblock: 0
2025-11-21 17:36:55,323 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674474) isrss: 0
2025-11-21 17:36:55,324 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674474) ixrss: 0
2025-11-21 17:36:55,324 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674474) majflt: 0
2025-11-21 17:36:55,324 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674474) maxrss: 484476
2025-11-21 17:36:55,325 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674474) minflt: 45696
2025-11-21 17:36:55,325 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674474) msgrcv: 0
2025-11-21 17:36:55,325 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674474) msgsnd: 0
2025-11-21 17:36:55,330 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674474) nivcsw: 159
2025-11-21 17:36:55,330 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674474) nsignals: 0
2025-11-21 17:36:55,331 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674474) nswap: 0
2025-11-21 17:36:55,331 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674474) nvcsw: 15
2025-11-21 17:36:55,331 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674474) oublock: 8
2025-11-21 17:36:55,332 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674474) stime: 0.226819
2025-11-21 17:36:55,332 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674474) utime: 0.5554089999999999
2025-11-21 17:36:55,332 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674474) wtime: 1.034
2025-11-21 17:36:55,333 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674474) output:
Arc info:
    Branch: unknown-vcs-branch
    Commit: THIS_REVISION_IS_A_DUMMY
    Author: ordinal
    Summary: No VCS
    Last Changed Rev: -1
    Last Changed Date: 2015-03-14T06:05:35.000000Z
Other info:
    Build by: runner
    Top src dir: 
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-zme4sewyte    Host information: 
        Linux ghrun-zme4sewyte 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/10302026024/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10302026024/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-11-21 17:36:55,334 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674474) errors:

2025-11-21 17:36:55,335 - INFO - __tests__.base.673571  - _setup_ydb: Arc info:
    Branch: unknown-vcs-branch
    Commit: THIS_REVISION_IS_A_DUMMY
    Author: ordinal
    Summary: No VCS
    Last Changed Rev: -1
    Last Changed Date: 2015-03-14T06:05:35.000000Z
Other info:
    Build by: runner
    Top src dir: 
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-zme4sewyte    Host information: 
        Linux ghrun-zme4sewyte 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/10302026024/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10302026024/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-11-21 17:36:55,530 - DEBUG - ya.test.673571  - get_binary: Binary was found by /home/runner/.ya/build/build_root/ue5z/0055a5/ydb/apps/ydbd/ydbd
2025-11-21 17:36:55,532 - DEBUG - library.python.filelock.673571  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/6951
2025-11-21 17:36:55,534 - DEBUG - ydb.tests.library.harness.kikimr_runner.673571  - start: Working directory: /home/runner/.ya/build/build_root/ue5z/0055a5/r3tmp/kikimr_cluster_1l0lp53_
2025-11-21 17:36:55,581 - DEBUG - ya.test.673571  - get_binary: Binary was found by /home/runner/.ya/build/build_root/ue5z/0055a5/ydb/apps/ydbd/ydbd
2025-11-21 17:36:55,584 - DEBUG - library.python.filelock.673571  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/23758
2025-11-21 17:36:55,584 - DEBUG - library.python.filelock.673571  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/16227
2025-11-21 17:36:55,585 - DEBUG - library.python.filelock.673571  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/27468
2025-11-21 17:36:55,586 - DEBUG - library.python.filelock.673571  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18812
2025-11-21 17:36:55,587 - INFO - ydb.tests.library.harness.kikimr_runner.673571  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/ue5z/0055a5/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_20_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.20/cluster/kikimr_configs"
2025-11-21 17:36:55,587 - INFO - ydb.tests.library.harness.kikimr_runner.673571  - __make_run_command: Final command: /home/runner/.ya/build/build_root/ue5z/0055a5/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/ue5z/0055a5/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_20_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.20/cluster/node_1/logfile__a7q5na4.log --grpc-port=23758 --mon-port=16227 --ic-port=6951
2025-11-21 17:36:55,588 - DEBUG - ydb.tests.library.harness.kikimr_runner.673571  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:23758/1, disk_size 68719476736
2025-11-21 17:36:55,588 - INFO - ydb.tests.library.harness.kikimr_runner.673571  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/ue5z/0055a5/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_20_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.20/cluster/kikimr_configs"
2025-11-21 17:36:55,592 - INFO - ydb.tests.library.harness.kikimr_runner.673571  - __make_run_command: Final command: /home/runner/.ya/build/build_root/ue5z/0055a5/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/ue5z/0055a5/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_20_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.20/cluster/node_1/logfile__a7q5na4.log --grpc-port=23758 --mon-port=16227 --ic-port=6951
2025-11-21 17:36:55,593 - DEBUG - ya.test.673571  - execute: Executing '('/home/runner/.ya/build/build_root/ue5z/0055a5/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/ue5z/0055a5/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_20_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.20/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/ue5z/0055a5/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_20_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.20/cluster/node_1/logfile__a7q5na4.log', '--grpc-port=23758', '--mon-port=16227', '--ic-port=6951')' in '/home/runner/.ya/build/build_root/ue5z/0055a5/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_20_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.20/cluster/node_1' (no wait)
2025-11-21 17:36:55,596 - DEBUG - ya.test.673571  - execute: Command pid: 674914
2025-11-21 17:36:55,597 - INFO - ydb.tests.library.harness.kikimr_runner.673571  - start: Started node localhost:23758/1
2025-11-21 17:36:55,599 - DEBUG - ya.test.673571  - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-21 17:36:55,600 - DEBUG - ya.test.673571  - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-21 17:36:55,600 - DEBUG - ya.test.673571  - execute: Executing '['/home/runner/.ya/build/build_root/ue5z/0055a5/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-21 17:36:55,602 - DEBUG - ya.test.673571  - execute: Command pid: 674915
2025-11-21 17:36:56,925 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674915) rc: 0
2025-11-21 17:36:56,926 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674915) elapsed time (sec): 1.3218200206756592
2025-11-21 17:36:56,926 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674915) idrss: 0
2025-11-21 17:36:56,927 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674915) inblock: 0
2025-11-21 17:36:56,927 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674915) isrss: 0
2025-11-21 17:36:56,927 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674915) ixrss: 0
2025-11-21 17:36:56,928 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674915) majflt: 0
2025-11-21 17:36:56,928 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674915) maxrss: 484388
2025-11-21 17:36:56,928 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674915) minflt: 45848
2025-11-21 17:36:56,929 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674915) msgrcv: 0
2025-11-21 17:36:56,929 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674915) msgsnd: 0
2025-11-21 17:36:56,930 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674915) nivcsw: 180
2025-11-21 17:36:56,931 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674915) nsignals: 0
2025-11-21 17:36:56,931 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674915) nswap: 0
2025-11-21 17:36:56,931 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674915) nvcsw: 13
2025-11-21 17:36:56,931 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674915) oublock: 8
2025-11-21 17:36:56,932 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674915) stime: 0.20973699999999998
2025-11-21 17:36:56,932 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674915) utime: 0.555111
2025-11-21 17:36:56,932 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674915) wtime: 1.324
2025-11-21 17:36:56,933 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674915) output:
Arc info:
    Branch: unknown-vcs-branch
    Commit: THIS_REVISION_IS_A_DUMMY
    Author: ordinal
    Summary: No VCS
    Last Changed Rev: -1
    Last Changed Date: 2015-03-14T06:05:35.000000Z
Other info:
    Build by: runner
    Top src dir: 
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-zme4sewyte    Host information: 
        Linux ghrun-zme4sewyte 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/10302026024/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10302026024/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-11-21 17:36:56,938 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 674915) errors:

2025-11-21 17:36:56,939 - INFO - ydb.tests.library.harness.kikimr_runner.673571  - start: Node 1 version:
Arc info:
    Branch: unknown-vcs-branch
    Commit: THIS_REVISION_IS_A_DUMMY
    Author: ordinal
    Summary: No VCS
    Last Changed Rev: -1
    Last Changed Date: 2015-03-14T06:05:35.000000Z
Other info:
    Build by: runner
    Top src dir: 
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-zme4sewyte    Host information: 
        Linux ghrun-zme4sewyte 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64
2025-11-21 17:37:02,513 - DEBUG - ya.test.673571  - get_binary: Binary was found by /home/runner/.ya/build/build_root/ue5z/0055a5/ydb/apps/ydbd/ydbd
2025-11-21 17:37:02,515 - DEBUG - ydb.tests.library.harness.kikimr_runner.673571  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/ue5z/0055a5/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:23758', '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: 6951\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-21 17:37:02,516 - DEBUG - ya.test.673571  - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-21 17:37:02,517 - DEBUG - ya.test.673571  - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-21 17:37:02,517 - DEBUG - ya.test.673571  - execute: Executing '['/home/runner/.ya/build/build_root/ue5z/0055a5/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:23758', '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: 6951\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-21 17:37:02,535 - DEBUG - ya.test.673571  - execute: Command pid: 676076
2025-11-21 17:37:04,014 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676076) rc: 0
2025-11-21 17:37:04,015 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676076) elapsed time (sec): 1.4777448177337646
2025-11-21 17:37:04,015 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676076) idrss: 0
2025-11-21 17:37:04,015 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676076) inblock: 0
2025-11-21 17:37:04,016 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676076) isrss: 0
2025-11-21 17:37:04,016 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676076) ixrss: 0
2025-11-21 17:37:04,016 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676076) majflt: 0
2025-11-21 17:37:04,017 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676076) maxrss: 594824
2025-11-21 17:37:04,017 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676076) minflt: 51840
2025-11-21 17:37:04,017 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676076) msgrcv: 0
2025-11-21 17:37:04,017 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676076) msgsnd: 0
2025-11-21 17:37:04,018 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676076) nivcsw: 223
2025-11-21 17:37:04,018 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676076) nsignals: 0
2025-11-21 17:37:04,018 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676076) nswap: 0
2025-11-21 17:37:04,019 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676076) nvcsw: 549
2025-11-21 17:37:04,019 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676076) oublock: 8
2025-11-21 17:37:04,019 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676076) stime: 0.379056
2025-11-21 17:37:04,020 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676076) utime: 0.550084
2025-11-21 17:37:04,020 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676076) wtime: 1.496
2025-11-21 17:37:04,020 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676076) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-21 17:37:04,021 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676076) errors:

2025-11-21 17:37:04,031 - DEBUG - ya.test.673571  - get_binary: Binary was found by /home/runner/.ya/build/build_root/ue5z/0055a5/ydb/apps/ydbd/ydbd
2025-11-21 17:37:04,031 - DEBUG - ydb.tests.library.harness.kikimr_runner.673571  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/ue5z/0055a5/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:23758', '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-11-21 17:37:04,033 - DEBUG - ya.test.673571  - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-21 17:37:04,034 - DEBUG - ya.test.673571  - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-21 17:37:04,034 - DEBUG - ya.test.673571  - execute: Executing '['/home/runner/.ya/build/build_root/ue5z/0055a5/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:23758', '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-11-21 17:37:04,052 - DEBUG - ya.test.673571  - execute: Command pid: 676227
2025-11-21 17:37:05,292 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676227) rc: 0
2025-11-21 17:37:05,293 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676227) elapsed time (sec): 1.2388231754302979
2025-11-21 17:37:05,293 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676227) idrss: 0
2025-11-21 17:37:05,294 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676227) inblock: 0
2025-11-21 17:37:05,294 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676227) isrss: 0
2025-11-21 17:37:05,295 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676227) ixrss: 0
2025-11-21 17:37:05,295 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676227) majflt: 0
2025-11-21 17:37:05,295 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676227) maxrss: 595956
2025-11-21 17:37:05,295 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676227) minflt: 51969
2025-11-21 17:37:05,296 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676227) msgrcv: 0
2025-11-21 17:37:05,296 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676227) msgsnd: 0
2025-11-21 17:37:05,297 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676227) nivcsw: 236
2025-11-21 17:37:05,297 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676227) nsignals: 0
2025-11-21 17:37:05,298 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676227) nswap: 0
2025-11-21 17:37:05,298 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676227) nvcsw: 396
2025-11-21 17:37:05,298 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676227) oublock: 8
2025-11-21 17:37:05,298 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676227) stime: 0.269184
2025-11-21 17:37:05,299 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676227) utime: 0.603482
2025-11-21 17:37:05,299 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676227) wtime: 1.257
2025-11-21 17:37:05,299 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676227) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-11-21 17:37:05,300 - DEBUG - ya.test.673571  - _save_outputs: Command (pid 676227) errors:

2025-11-21 17:37:05,300 - INFO - ydb.tests.library.harness.kikimr_runner.673571  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-21 17:37:05,449 - INFO - ydb.tests.library.harness.kikimr_runner.673571  - __run: Cluster started and initialized
2025-11-21 17:37:05,532 - DEBUG - ydb.connection.673571  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-21 17:37:05,542 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.673571  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-21 17:37:05,543 - DEBUG - ydb.connection.673571  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-21 17:37:05,586 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.673571  - context_resolve: Resolving endpoints for database /Root
2025-11-21 17:37:05,587 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ListEndpoints, 93fb62cd-d768-4d74-bbe1-b4d0e79b2bac, localhost:23758): creating call state
2025-11-21 17:37:05,588 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ListEndpoints, 93fb62cd-d768-4d74-bbe1-b4d0e79b2bac, localhost:23758): request = { database: "/Root" }
2025-11-21 17:37:05,604 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ListEndpoints, 93fb62cd-d768-4d74-bbe1-b4d0e79b2bac, localhost:23758): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-zme4sewyte.auto.internal" port: 23758 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-11-21 17:37:05,606 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.673571  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-zme4sewyte.auto.internal:23758, location 1, ssl: False>]>
2025-11-21 17:37:05,607 - DEBUG - ydb.connection.673571  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-21 17:37:05,646 - DEBUG - ydb.connection.673571  - close: Closing channel for endpoint localhost:23758
2025-11-21 17:37:05,647 - DEBUG - ydb.query.pool.673571  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-21 17:37:05,649 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(CreateSession, 1b012e74-8022-4da7-a5e2-a208ea69ed1d, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:05,650 - DEBUG - ydb.connection.673571  - _log_request: RpcState(CreateSession, 1b012e74-8022-4da7-a5e2-a208ea69ed1d, ghrun-zme4sewyte.auto.internal:23758): request = {  }
2025-11-21 17:37:05,663 - DEBUG - ydb.connection.673571  - _log_response: RpcState(CreateSession, 1b012e74-8022-4da7-a5e2-a208ea69ed1d, ghrun-zme4sewyte.auto.internal:23758): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" node_id: 1 }
2025-11-21 17:37:05,665 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(AttachSession, d7ba3647-dcfd-4c67-9f0d-2e47ef914035, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:05,665 - DEBUG - ydb.connection.673571  - _log_request: RpcState(AttachSession, d7ba3647-dcfd-4c67-9f0d-2e47ef914035, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" }
2025-11-21 17:37:05,675 - DEBUG - ydb.connection.673571  - _log_response: RpcState(AttachSession, d7ba3647-dcfd-4c67-9f0d-2e47ef914035, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:05,685 - DEBUG - ydb.query.pool.673571  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:05,687 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, d3f18474-2677-4152-b420-15ea07a348ee, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:05,688 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, d3f18474-2677-4152-b420-15ea07a348ee, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/off_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"off\")\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:05,694 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, d3f18474-2677-4152-b420-15ea07a348ee, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:08,745 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:08,746 - INFO - __tests__.alter_compression.673571  - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-11-21 17:37:08,746 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:08,747 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 6d2a30c2-8fba-42c9-83ee-f7a258231c51, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:08,748 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 6d2a30c2-8fba-42c9-83ee-f7a258231c51, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/off_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:08,750 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 6d2a30c2-8fba-42c9-83ee-f7a258231c51, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:10,110 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:10,111 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:10,112 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, fee2a484-f772-47c9-887f-9ca853a6903a, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:10,113 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, fee2a484-f772-47c9-887f-9ca853a6903a, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 0;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:10,119 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, fee2a484-f772-47c9-887f-9ca853a6903a, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:11,672 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:11,673 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:11,674 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 6c7c4636-ab5b-46e7-ad20-f7bc2c862625, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:11,675 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 6c7c4636-ab5b-46e7-ad20-f7bc2c862625, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:11,677 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 6c7c4636-ab5b-46e7-ad20-f7bc2c862625, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:12,903 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:12,904 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:12,905 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, edfeeed7-5113-4337-863f-7d4caf4193c5, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:12,907 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, edfeeed7-5113-4337-863f-7d4caf4193c5, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:12,908 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, edfeeed7-5113-4337-863f-7d4caf4193c5, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:14,927 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:14,928 - INFO - __tests__.alter_compression.673571  - 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-11-21 17:37:14,929 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:14,930 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, bb4afcb1-c362-46bb-be6a-52a19283e976, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:14,931 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, bb4afcb1-c362-46bb-be6a-52a19283e976, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 100000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:14,938 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, bb4afcb1-c362-46bb-be6a-52a19283e976, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:16,364 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:16,365 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:16,365 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 94821732-2f00-4542-8d62-be6b655009c4, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:16,366 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 94821732-2f00-4542-8d62-be6b655009c4, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:16,369 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 94821732-2f00-4542-8d62-be6b655009c4, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:16,726 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:16,727 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:16,728 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, a1e5efe4-c69d-4a8e-a5d8-f08cd95ee8af, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:16,729 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, a1e5efe4-c69d-4a8e-a5d8-f08cd95ee8af, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:16,731 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, a1e5efe4-c69d-4a8e-a5d8-f08cd95ee8af, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:17,260 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:17,261 - INFO - __tests__.alter_compression.673571  - 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-11-21 17:37:17,261 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:17,261 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 6adbc600-bb09-4b69-9648-3b44ee50d53c, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:17,262 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 6adbc600-bb09-4b69-9648-3b44ee50d53c, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 200000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:17,263 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 6adbc600-bb09-4b69-9648-3b44ee50d53c, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:18,503 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:18,504 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:18,505 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 324ef494-6d08-47bf-8eb3-d76d70cb3b51, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:18,506 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 324ef494-6d08-47bf-8eb3-d76d70cb3b51, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:18,508 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 324ef494-6d08-47bf-8eb3-d76d70cb3b51, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:18,800 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:18,801 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:18,802 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, b38933a2-505e-4912-a721-b992ffd5e5d1, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:18,803 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, b38933a2-505e-4912-a721-b992ffd5e5d1, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:18,806 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, b38933a2-505e-4912-a721-b992ffd5e5d1, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:19,330 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:19,331 - INFO - __tests__.alter_compression.673571  - 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-11-21 17:37:19,331 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:19,332 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 50e24ee8-b78c-4cc8-8749-e300d127f845, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:19,333 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 50e24ee8-b78c-4cc8-8749-e300d127f845, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 300000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:19,347 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 50e24ee8-b78c-4cc8-8749-e300d127f845, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:20,727 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:20,728 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:20,729 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, fe4bc7ff-f017-44bc-ad2a-4b091a5ab7f5, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:20,731 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, fe4bc7ff-f017-44bc-ad2a-4b091a5ab7f5, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:20,734 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, fe4bc7ff-f017-44bc-ad2a-4b091a5ab7f5, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:21,057 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:21,058 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:21,059 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, b980ac6d-9cc4-46a7-8410-6e2cee02cc41, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:21,060 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, b980ac6d-9cc4-46a7-8410-6e2cee02cc41, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:21,071 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, b980ac6d-9cc4-46a7-8410-6e2cee02cc41, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:21,812 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:21,813 - INFO - __tests__.alter_compression.673571  - 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-11-21 17:37:21,813 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:21,814 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, d81c9aa9-ccb2-4725-9110-1e8e747da5eb, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:21,815 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, d81c9aa9-ccb2-4725-9110-1e8e747da5eb, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 400000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:21,817 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, d81c9aa9-ccb2-4725-9110-1e8e747da5eb, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:23,395 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:23,396 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:23,397 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 78fd8d80-002e-4a5c-a1e1-fd11e20bb461, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:23,398 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 78fd8d80-002e-4a5c-a1e1-fd11e20bb461, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:23,400 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 78fd8d80-002e-4a5c-a1e1-fd11e20bb461, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:23,936 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:23,937 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:23,938 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 8180c928-f489-4813-80d6-ff9067fb7f5e, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:23,939 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 8180c928-f489-4813-80d6-ff9067fb7f5e, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:23,940 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 8180c928-f489-4813-80d6-ff9067fb7f5e, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:24,509 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:24,510 - INFO - __tests__.alter_compression.673571  - 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-11-21 17:37:24,511 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:24,511 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 50afbdcb-b337-4f8d-9975-47537d18e3d2, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:24,512 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 50afbdcb-b337-4f8d-9975-47537d18e3d2, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 500000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:24,516 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 50afbdcb-b337-4f8d-9975-47537d18e3d2, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:25,719 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:25,720 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:25,720 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 13d35869-46a9-4ee2-b430-2dc8a074457a, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:25,721 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 13d35869-46a9-4ee2-b430-2dc8a074457a, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:25,724 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 13d35869-46a9-4ee2-b430-2dc8a074457a, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:26,055 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:26,055 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:26,056 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 3b3b95ff-9ed2-4a9a-bea9-e0b59aac1ef8, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:26,057 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 3b3b95ff-9ed2-4a9a-bea9-e0b59aac1ef8, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:26,059 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 3b3b95ff-9ed2-4a9a-bea9-e0b59aac1ef8, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:26,716 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:26,717 - INFO - __tests__.alter_compression.673571  - 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-11-21 17:37:26,717 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:26,718 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 8fd2294a-cb57-47f3-bab5-a162a9b0eb03, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:26,719 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 8fd2294a-cb57-47f3-bab5-a162a9b0eb03, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 600000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:26,727 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 8fd2294a-cb57-47f3-bab5-a162a9b0eb03, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:27,810 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:27,811 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:27,819 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, cb2e89f3-78fd-425c-84b0-dbc2a6693c16, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:27,820 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, cb2e89f3-78fd-425c-84b0-dbc2a6693c16, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:27,821 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, cb2e89f3-78fd-425c-84b0-dbc2a6693c16, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:28,150 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:28,151 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:28,152 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, be6ce36f-d6ee-4958-8568-01be58672e9c, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:28,153 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, be6ce36f-d6ee-4958-8568-01be58672e9c, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:28,154 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, be6ce36f-d6ee-4958-8568-01be58672e9c, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:28,820 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:28,820 - INFO - __tests__.alter_compression.673571  - 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-11-21 17:37:28,821 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:28,822 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, f031f216-bef7-4c90-a00a-75a129d954d4, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:28,823 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, f031f216-bef7-4c90-a00a-75a129d954d4, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 700000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:28,824 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, f031f216-bef7-4c90-a00a-75a129d954d4, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:30,219 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:30,220 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:30,221 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, e3e29b62-fc0b-4853-bf6c-1212e80872da, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:30,222 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, e3e29b62-fc0b-4853-bf6c-1212e80872da, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:30,223 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, e3e29b62-fc0b-4853-bf6c-1212e80872da, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:30,627 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:30,628 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:30,629 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 19b9d6af-d56e-4174-bf45-b7910c35dc4f, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:30,630 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 19b9d6af-d56e-4174-bf45-b7910c35dc4f, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:30,631 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 19b9d6af-d56e-4174-bf45-b7910c35dc4f, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:31,405 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:31,406 - INFO - __tests__.alter_compression.673571  - 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-11-21 17:37:31,407 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:31,407 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 070cbe25-8e39-4729-87cf-15c7173b5019, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:31,408 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 070cbe25-8e39-4729-87cf-15c7173b5019, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 800000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:31,414 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 070cbe25-8e39-4729-87cf-15c7173b5019, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:32,707 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:32,708 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:32,709 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 53d08552-83b3-455f-9e1e-ddd8472ca76c, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:32,710 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 53d08552-83b3-455f-9e1e-ddd8472ca76c, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:32,718 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 53d08552-83b3-455f-9e1e-ddd8472ca76c, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:33,087 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:33,088 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:33,088 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 49d21600-2173-4c97-a6e9-1462b0d73bdb, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:33,089 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 49d21600-2173-4c97-a6e9-1462b0d73bdb, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:33,091 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 49d21600-2173-4c97-a6e9-1462b0d73bdb, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:33,816 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:33,816 - INFO - __tests__.alter_compression.673571  - 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-11-21 17:37:33,817 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:33,818 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 70ba7563-86bd-46f0-91d9-1ada07e485ee, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:33,819 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 70ba7563-86bd-46f0-91d9-1ada07e485ee, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 900000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:33,830 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 70ba7563-86bd-46f0-91d9-1ada07e485ee, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:35,114 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:35,115 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:35,116 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, d37d5c1c-790f-4a9a-86e9-45713a0ffc7a, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:35,117 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, d37d5c1c-790f-4a9a-86e9-45713a0ffc7a, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:35,127 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, d37d5c1c-790f-4a9a-86e9-45713a0ffc7a, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:35,699 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:35,700 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:35,700 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, d6f5eec7-b536-4daf-be78-9af248ee8a8e, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:35,701 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, d6f5eec7-b536-4daf-be78-9af248ee8a8e, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:35,703 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, d6f5eec7-b536-4daf-be78-9af248ee8a8e, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:36,957 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:36,958 - INFO - __tests__.alter_compression.673571  - 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-11-21 17:37:36,958 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:36,959 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 62ca5857-a3a1-4d4e-88c7-1cf5dc608957, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:36,960 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 62ca5857-a3a1-4d4e-88c7-1cf5dc608957, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/off_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:36,963 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 62ca5857-a3a1-4d4e-88c7-1cf5dc608957, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:38,130 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:38,131 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:38,132 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 97aa3cf8-843e-4d2d-a5ef-4652eccbc99e, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:38,133 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 97aa3cf8-843e-4d2d-a5ef-4652eccbc99e, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:38,135 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 97aa3cf8-843e-4d2d-a5ef-4652eccbc99e, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:38,486 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:38,487 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:38,488 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, f421d36e-10ae-44a8-8fab-eec00f2cad6b, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:38,489 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, f421d36e-10ae-44a8-8fab-eec00f2cad6b, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:38,492 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, f421d36e-10ae-44a8-8fab-eec00f2cad6b, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:38,899 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:38,900 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:38,900 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 33ade8b2-6003-4af2-96f9-2a946a753427, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:38,901 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 33ade8b2-6003-4af2-96f9-2a946a753427, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:38,903 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 33ade8b2-6003-4af2-96f9-2a946a753427, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:43,471 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:53,513 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:53,514 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, c8be6009-087e-4c6a-a75e-425b2ba39470, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:53,515 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, c8be6009-087e-4c6a-a75e-425b2ba39470, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:53,516 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, c8be6009-087e-4c6a-a75e-425b2ba39470, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:37:57,484 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:57,518 - INFO - root.673571  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-21 17:37:57,519 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:37:57,520 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 778e6b82-5cc7-44d7-9317-12644b0e5c03, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:37:57,521 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 778e6b82-5cc7-44d7-9317-12644b0e5c03, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:37:57,522 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 778e6b82-5cc7-44d7-9317-12644b0e5c03, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:38:02,307 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:38:12,412 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:38:12,413 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 4ae59836-19a7-440c-8681-106f1f78f21a, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:38:12,414 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 4ae59836-19a7-440c-8681-106f1f78f21a, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:38:12,415 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 4ae59836-19a7-440c-8681-106f1f78f21a, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:38:16,181 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:38:26,214 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:38:26,215 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 570393fd-6ab7-4bdc-8a3f-373044a07a74, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:38:26,216 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 570393fd-6ab7-4bdc-8a3f-373044a07a74, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:38:26,227 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 570393fd-6ab7-4bdc-8a3f-373044a07a74, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:38:27,225 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:38:37,230 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:38:37,231 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 7276b686-4590-4586-845c-5a95d5144fcb, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:38:37,232 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 7276b686-4590-4586-845c-5a95d5144fcb, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:38:37,234 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 7276b686-4590-4586-845c-5a95d5144fcb, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:38:37,954 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:38:37,960 - INFO - root.673571  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8009216)
2025-11-21 17:38:37,961 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:38:37,962 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 6af632be-2e5e-448e-b8df-664a467ddeec, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:38:37,964 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 6af632be-2e5e-448e-b8df-664a467ddeec, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:38:37,966 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 6af632be-2e5e-448e-b8df-664a467ddeec, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:38:38,289 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:38:38,299 - INFO - ya.test.673571  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_20_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 20])
2025-11-21 17:38:38,301 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:38:38,310 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, c96b7a36-034e-4a4a-ac2b-0512982c6c6a, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:38:38,311 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, c96b7a36-034e-4a4a-ac2b-0512982c6c6a, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_20_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 20)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:38:38,312 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, c96b7a36-034e-4a4a-ac2b-0512982c6c6a, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:38:41,993 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:38:41,994 - INFO - __tests__.alter_compression.673571  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_20_compression created
2025-11-21 17:38:41,995 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:38:41,996 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 120b492b-ffef-4a6d-9cbc-af030253a79f, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:38:41,997 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 120b492b-ffef-4a6d-9cbc-af030253a79f, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_20_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:38:42,023 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 120b492b-ffef-4a6d-9cbc-af030253a79f, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:38:43,066 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:38:43,067 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:38:43,069 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 125f7fce-ca38-4891-bb89-8c6eae14af07, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:38:43,070 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 125f7fce-ca38-4891-bb89-8c6eae14af07, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:38:43,072 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 125f7fce-ca38-4891-bb89-8c6eae14af07, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:38:48,106 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:38:48,107 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:38:48,108 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, f78e2c73-d108-46e2-aba5-7f75241bd851, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:38:48,108 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, f78e2c73-d108-46e2-aba5-7f75241bd851, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:38:48,110 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, f78e2c73-d108-46e2-aba5-7f75241bd851, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:38:48,683 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.673571  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-21 17:38:48,684 - DEBUG - ydb.connection.673571  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-21 17:38:48,725 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.673571  - context_resolve: Resolving endpoints for database /Root
2025-11-21 17:38:48,727 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ListEndpoints, a397ec73-ef4c-49c6-908a-bcb8b01054c1, localhost:23758): creating call state
2025-11-21 17:38:48,727 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ListEndpoints, a397ec73-ef4c-49c6-908a-bcb8b01054c1, localhost:23758): request = { database: "/Root" }
2025-11-21 17:38:48,760 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ListEndpoints, a397ec73-ef4c-49c6-908a-bcb8b01054c1, localhost:23758): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-zme4sewyte.auto.internal" port: 23758 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-11-21 17:38:48,761 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.673571  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-zme4sewyte.auto.internal:23758, location 1, ssl: False>]>
2025-11-21 17:38:48,773 - DEBUG - ydb.connection.673571  - close: Closing channel for endpoint localhost:23758
2025-11-21 17:38:48,962 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:38:48,962 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:38:48,963 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 74861ccc-146d-41c8-a937-e65c1f8f4d6f, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:38:48,964 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 74861ccc-146d-41c8-a937-e65c1f8f4d6f, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:38:48,966 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 74861ccc-146d-41c8-a937-e65c1f8f4d6f, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:38:50,783 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:38:50,784 - INFO - __tests__.alter_compression.673571  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318528, 'BlobCount': 128}}
2025-11-21 17:38:50,785 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:38:50,786 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, e185a68a-c54e-4fc3-ae53-4db1c740d93f, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:38:50,786 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, e185a68a-c54e-4fc3-ae53-4db1c740d93f, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:38:50,788 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, e185a68a-c54e-4fc3-ae53-4db1c740d93f, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:38:56,298 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:38:56,299 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:38:56,299 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, c4cba12c-d36e-4d72-8e4a-3aace959944f, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:38:56,300 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, c4cba12c-d36e-4d72-8e4a-3aace959944f, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:38:56,310 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, c4cba12c-d36e-4d72-8e4a-3aace959944f, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:38:56,726 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:38:56,727 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:38:56,728 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, bb4e7978-7a49-4f3e-a1e7-ffb34601b9be, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:38:56,729 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, bb4e7978-7a49-4f3e-a1e7-ffb34601b9be, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:38:56,731 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, bb4e7978-7a49-4f3e-a1e7-ffb34601b9be, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:38:57,193 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:38:57,193 - INFO - __tests__.alter_compression.673571  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 637920, 'BlobCount': 256}}
2025-11-21 17:38:57,194 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:38:57,194 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 1957e361-012b-4cfe-a6df-dc982649d317, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:38:57,195 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 1957e361-012b-4cfe-a6df-dc982649d317, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:38:57,196 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 1957e361-012b-4cfe-a6df-dc982649d317, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:39:02,153 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:02,154 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:02,155 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 27193e6b-62ed-48cb-a0d5-7d92763f99af, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:39:02,156 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 27193e6b-62ed-48cb-a0d5-7d92763f99af, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:39:02,159 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 27193e6b-62ed-48cb-a0d5-7d92763f99af, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:39:02,463 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:02,464 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:02,465 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, c1e2b5e9-ff9b-4358-b60c-bbbbc240a014, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:39:02,466 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, c1e2b5e9-ff9b-4358-b60c-bbbbc240a014, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:39:02,469 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, c1e2b5e9-ff9b-4358-b60c-bbbbc240a014, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:39:02,858 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:02,859 - INFO - __tests__.alter_compression.673571  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 956816, 'BlobCount': 384}}
2025-11-21 17:39:02,859 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:02,860 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, f7dae14b-f150-4df9-8b42-a46a15612240, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:39:02,861 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, f7dae14b-f150-4df9-8b42-a46a15612240, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:39:02,863 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, f7dae14b-f150-4df9-8b42-a46a15612240, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:39:08,018 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:08,019 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:08,020 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 0907ec5e-06ea-4022-824a-d3f46d49a0d7, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:39:08,021 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 0907ec5e-06ea-4022-824a-d3f46d49a0d7, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:39:08,031 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 0907ec5e-06ea-4022-824a-d3f46d49a0d7, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:39:08,495 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:08,496 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:08,497 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 0dbd8a0a-d190-4dcc-892a-e89b3d1d1779, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:39:08,501 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 0dbd8a0a-d190-4dcc-892a-e89b3d1d1779, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:39:08,503 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 0dbd8a0a-d190-4dcc-892a-e89b3d1d1779, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:39:09,366 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:09,367 - INFO - __tests__.alter_compression.673571  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1276240, 'BlobCount': 512}}
2025-11-21 17:39:09,367 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:09,368 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 478a67f6-39e2-4aaa-9493-ca5f9beae070, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:39:09,369 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 478a67f6-39e2-4aaa-9493-ca5f9beae070, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:39:09,385 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 478a67f6-39e2-4aaa-9493-ca5f9beae070, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:39:14,968 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:14,969 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:14,970 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 62f02032-5596-41ba-b5e9-4076fb87e50d, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:39:14,971 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 62f02032-5596-41ba-b5e9-4076fb87e50d, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:39:14,975 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 62f02032-5596-41ba-b5e9-4076fb87e50d, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:39:15,386 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:15,387 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:15,388 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 02442ead-5913-4615-976d-5c521f2e8d63, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:39:15,389 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 02442ead-5913-4615-976d-5c521f2e8d63, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:39:15,391 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 02442ead-5913-4615-976d-5c521f2e8d63, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:39:16,066 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:16,067 - INFO - __tests__.alter_compression.673571  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1595136, 'BlobCount': 640}}
2025-11-21 17:39:16,068 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:16,069 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, bd350693-9394-48d3-a4de-cdbe705db18e, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:39:16,070 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, bd350693-9394-48d3-a4de-cdbe705db18e, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:39:16,078 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, bd350693-9394-48d3-a4de-cdbe705db18e, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:39:21,662 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:21,663 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:21,663 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 12fef878-f893-46af-a941-ba776e42c1ab, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:39:21,664 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 12fef878-f893-46af-a941-ba776e42c1ab, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:39:21,667 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 12fef878-f893-46af-a941-ba776e42c1ab, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:39:22,002 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:22,003 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:22,004 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, d86bd7d7-b3c3-4be4-a2c1-8b50436a7b28, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:39:22,005 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, d86bd7d7-b3c3-4be4-a2c1-8b50436a7b28, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:39:22,006 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, d86bd7d7-b3c3-4be4-a2c1-8b50436a7b28, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:39:22,724 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:22,724 - INFO - __tests__.alter_compression.673571  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1914416, 'BlobCount': 768}}
2025-11-21 17:39:22,725 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:22,725 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, db032127-dd9d-4e8f-892a-8a4c7c1567b6, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:39:22,726 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, db032127-dd9d-4e8f-892a-8a4c7c1567b6, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:39:22,728 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, db032127-dd9d-4e8f-892a-8a4c7c1567b6, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:39:28,222 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:28,223 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:28,224 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 22c24475-b927-4e89-af90-701ada0461e3, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:39:28,224 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 22c24475-b927-4e89-af90-701ada0461e3, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:39:28,226 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 22c24475-b927-4e89-af90-701ada0461e3, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:39:28,684 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:28,685 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:28,686 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, c02010db-4c69-4949-928d-d3ce666d4b3c, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:39:28,687 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, c02010db-4c69-4949-928d-d3ce666d4b3c, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:39:28,693 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, c02010db-4c69-4949-928d-d3ce666d4b3c, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:39:29,606 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:29,607 - INFO - __tests__.alter_compression.673571  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2233456, 'BlobCount': 896}}
2025-11-21 17:39:29,608 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:29,608 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 59d23dc4-3bcb-4e45-9ed4-5fda9e0ca741, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:39:29,609 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 59d23dc4-3bcb-4e45-9ed4-5fda9e0ca741, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:39:29,615 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 59d23dc4-3bcb-4e45-9ed4-5fda9e0ca741, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:39:35,688 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:35,689 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:35,689 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 6baa7fb8-6971-49af-859b-d5594a0a22cf, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:39:35,690 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 6baa7fb8-6971-49af-859b-d5594a0a22cf, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:39:35,694 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 6baa7fb8-6971-49af-859b-d5594a0a22cf, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:39:36,178 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:36,179 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:36,180 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, f7c7abff-0cbb-4744-85e0-c9939cc822af, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:39:36,181 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, f7c7abff-0cbb-4744-85e0-c9939cc822af, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:39:36,184 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, f7c7abff-0cbb-4744-85e0-c9939cc822af, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:39:36,901 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:36,902 - INFO - __tests__.alter_compression.673571  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2552960, 'BlobCount': 1024}}
2025-11-21 17:39:36,902 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:36,903 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 6630685b-7c6b-4def-839d-cae548b50c71, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:39:36,904 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 6630685b-7c6b-4def-839d-cae548b50c71, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:39:36,908 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 6630685b-7c6b-4def-839d-cae548b50c71, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:39:43,079 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:43,080 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:43,081 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, d2744fe8-0b5d-4d00-b2c8-af4ed75e9f36, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:39:43,082 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, d2744fe8-0b5d-4d00-b2c8-af4ed75e9f36, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:39:43,086 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, d2744fe8-0b5d-4d00-b2c8-af4ed75e9f36, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:39:43,737 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:43,738 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:43,739 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, afed9393-6ee2-42eb-897d-3ea2b3fbe479, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:39:43,740 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, afed9393-6ee2-42eb-897d-3ea2b3fbe479, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:39:43,743 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, afed9393-6ee2-42eb-897d-3ea2b3fbe479, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:39:44,830 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:44,831 - INFO - __tests__.alter_compression.673571  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2871840, 'BlobCount': 1152}}
2025-11-21 17:39:44,832 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:44,833 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 14c70d08-e217-4399-8143-7b1a88d913e8, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:39:44,834 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 14c70d08-e217-4399-8143-7b1a88d913e8, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:39:44,835 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 14c70d08-e217-4399-8143-7b1a88d913e8, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:39:50,192 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:50,193 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:50,194 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 6a64e3f8-8970-4405-a333-594a14071e16, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:39:50,195 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 6a64e3f8-8970-4405-a333-594a14071e16, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:39:50,196 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 6a64e3f8-8970-4405-a333-594a14071e16, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:39:50,563 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:50,564 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:50,565 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, e65fcbe5-dc9d-4c23-89b1-6290088ff693, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:39:50,566 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, e65fcbe5-dc9d-4c23-89b1-6290088ff693, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 17:39:50,569 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, e65fcbe5-dc9d-4c23-89b1-6290088ff693, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:39:51,318 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:51,319 - INFO - __tests__.alter_compression.673571  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_20_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3191408, 'BlobCount': 1280}}
2025-11-21 17:39:51,320 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:51,320 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 62e5305f-f22f-4d67-be13-451c5eca4e3a, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:39:51,321 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 62e5305f-f22f-4d67-be13-451c5eca4e3a, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_20_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:39:51,323 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 62e5305f-f22f-4d67-be13-451c5eca4e3a, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:39:52,549 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:52,550 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:52,551 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, dd550dd0-2579-4644-ac03-717d2d303619, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:39:52,552 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, dd550dd0-2579-4644-ac03-717d2d303619, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:39:52,555 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, dd550dd0-2579-4644-ac03-717d2d303619, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:39:52,861 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:52,862 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:52,863 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, b093e3c6-b76e-4cff-b4f7-daeca9d6bf87, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:39:52,865 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, b093e3c6-b76e-4cff-b4f7-daeca9d6bf87, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:39:52,867 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, b093e3c6-b76e-4cff-b4f7-daeca9d6bf87, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:39:53,156 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:53,157 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:39:53,157 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, e01be107-3a16-4ec2-95b7-f7a09c082a92, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:39:53,158 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, e01be107-3a16-4ec2-95b7-f7a09c082a92, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_20_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:39:53,159 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, e01be107-3a16-4ec2-95b7-f7a09c082a92, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:39:57,645 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:40:07,696 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:40:07,697 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 826f7abc-230d-4eef-a0a9-ccb71a3d4bc3, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:40:07,698 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 826f7abc-230d-4eef-a0a9-ccb71a3d4bc3, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_20_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:40:07,699 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 826f7abc-230d-4eef-a0a9-ccb71a3d4bc3, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:40:12,450 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.673571  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-21 17:40:12,451 - DEBUG - ydb.connection.673571  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-21 17:40:12,483 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.673571  - context_resolve: Resolving endpoints for database /Root
2025-11-21 17:40:12,484 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ListEndpoints, cc8197d6-20ba-4e55-9363-b08b4077330d, localhost:23758): creating call state
2025-11-21 17:40:12,484 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ListEndpoints, cc8197d6-20ba-4e55-9363-b08b4077330d, localhost:23758): request = { database: "/Root" }
2025-11-21 17:40:12,504 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ListEndpoints, cc8197d6-20ba-4e55-9363-b08b4077330d, localhost:23758): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-zme4sewyte.auto.internal" port: 23758 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-11-21 17:40:12,505 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.673571  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-zme4sewyte.auto.internal:23758, location 1, ssl: False>]>
2025-11-21 17:40:12,506 - DEBUG - ydb.connection.673571  - close: Closing channel for endpoint localhost:23758
2025-11-21 17:40:13,080 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:40:13,120 - INFO - root.673571  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_20_compression`, volumes `value` (8000000, 1595704)
2025-11-21 17:40:13,121 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:40:13,122 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, c970cc0f-cfe2-4f82-b602-17617b03df40, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:40:13,123 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, c970cc0f-cfe2-4f82-b602-17617b03df40, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" 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_20_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:40:13,124 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, c970cc0f-cfe2-4f82-b602-17617b03df40, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:40:13,714 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:40:13,715 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:40:13,715 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, dadcfa3d-dda5-4801-99a6-97905671ee17, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:40:13,716 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, dadcfa3d-dda5-4801-99a6-97905671ee17, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_20_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:40:13,720 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, dadcfa3d-dda5-4801-99a6-97905671ee17, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:40:18,983 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:40:29,047 - DEBUG - ydb.query.pool.673571  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:40:29,047 - DEBUG - ydb.connection.673571  - _prepare_call: RpcState(ExecuteQuery, 93d3033e-5674-4a36-a2aa-fd3bf907c151, ghrun-zme4sewyte.auto.internal:23758): creating call state
2025-11-21 17:40:29,048 - DEBUG - ydb.connection.673571  - _log_request: RpcState(ExecuteQuery, 93d3033e-5674-4a36-a2aa-fd3bf907c151, ghrun-zme4sewyte.auto.internal:23758): request = { session_id: "ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_20_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 17:40:29,050 - DEBUG - ydb.connection.673571  - _log_response: RpcState(ExecuteQuery, 93d3033e-5674-4a36-a2aa-fd3bf907c151, ghrun-zme4sewyte.auto.internal:23758): response = { <_MultiThreadedRendezvous object> }
2025-11-21 17:40:33,311 - DEBUG - ydb.query.pool.673571  - release: Session returned to queue: ydb://session/3?node_id=1&id=NjgyMmY0NGEtYWM4NWI1YWQtMzdkOGUxMGEtZTZmZjU3ZDM=
2025-11-21 17:40:33,385 - INFO - root.673571  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_20_compression`, volumes `value` (8000000, 1595704)
2025-11-21 17:40:33,386 - INFO - root.673571  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_20_compression` 8092160 / 1595704: 5.071216215538722
2025-11-21 17:40:33,388 - INFO - ya.test.673571  - pytest_runtest_teardown: Test teardown
