2025-11-21 20:42:54,435 - INFO - ya.test.669953  - pytest_runtest_setup: ####################################################################################################
2025-11-21 20:42:54,435 - INFO - ya.test.669953  - pytest_runtest_setup: test_all_supported_compression[lz4_compression-COMPRESSION = "lz4"]
2025-11-21 20:42:54,435 - INFO - ya.test.669953  - pytest_runtest_setup: ####################################################################################################
2025-11-21 20:42:54,436 - INFO - ya.test.669953  - pytest_runtest_setup: Test setup
2025-11-21 20:42:54,438 - DEBUG - ya.test.669953  - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-21 20:42:54,439 - DEBUG - ya.test.669953  - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-21 20:42:54,439 - DEBUG - ya.test.669953  - execute: Executing '['/home/runner/.ya/build/build_root/tshh/002759/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-21 20:42:54,441 - DEBUG - ya.test.669953  - execute: Command pid: 672431
2025-11-21 20:42:55,155 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 672431) rc: 0
2025-11-21 20:42:55,175 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 672431) elapsed time (sec): 0.7134380340576172
2025-11-21 20:42:55,175 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 672431) idrss: 0
2025-11-21 20:42:55,175 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 672431) inblock: 0
2025-11-21 20:42:55,176 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 672431) isrss: 0
2025-11-21 20:42:55,176 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 672431) ixrss: 0
2025-11-21 20:42:55,176 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 672431) majflt: 0
2025-11-21 20:42:55,177 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 672431) maxrss: 492868
2025-11-21 20:42:55,177 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 672431) minflt: 45548
2025-11-21 20:42:55,177 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 672431) msgrcv: 0
2025-11-21 20:42:55,177 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 672431) msgsnd: 0
2025-11-21 20:42:55,177 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 672431) nivcsw: 72
2025-11-21 20:42:55,178 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 672431) nsignals: 0
2025-11-21 20:42:55,178 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 672431) nswap: 0
2025-11-21 20:42:55,178 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 672431) nvcsw: 14
2025-11-21 20:42:55,178 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 672431) oublock: 8
2025-11-21 20:42:55,179 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 672431) stime: 0.17743
2025-11-21 20:42:55,179 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 672431) utime: 0.482378
2025-11-21 20:42:55,179 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 672431) wtime: 0.715
2025-11-21 20:42:55,180 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 672431) 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-frzglb4yoy    Host information: 
        Linux ghrun-frzglb4yoy 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 20:42:55,180 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 672431) errors:

2025-11-21 20:42:55,180 - INFO - __tests__.base.669953  - _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-frzglb4yoy    Host information: 
        Linux ghrun-frzglb4yoy 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 20:42:55,280 - DEBUG - ya.test.669953  - get_binary: Binary was found by /home/runner/.ya/build/build_root/tshh/002759/ydb/apps/ydbd/ydbd
2025-11-21 20:42:55,282 - DEBUG - library.python.filelock.669953  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/19177
2025-11-21 20:42:55,282 - DEBUG - library.python.filelock.669953  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/19178
2025-11-21 20:42:55,284 - DEBUG - ydb.tests.library.harness.kikimr_runner.669953  - start: Working directory: /home/runner/.ya/build/build_root/tshh/002759/r3tmp/kikimr_cluster_5uw32_xr
2025-11-21 20:42:55,326 - DEBUG - ya.test.669953  - get_binary: Binary was found by /home/runner/.ya/build/build_root/tshh/002759/ydb/apps/ydbd/ydbd
2025-11-21 20:42:55,327 - DEBUG - library.python.filelock.669953  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/6190
2025-11-21 20:42:55,328 - DEBUG - library.python.filelock.669953  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/1274
2025-11-21 20:42:55,328 - DEBUG - library.python.filelock.669953  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/26902
2025-11-21 20:42:55,329 - DEBUG - library.python.filelock.669953  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/13440
2025-11-21 20:42:55,330 - INFO - ydb.tests.library.harness.kikimr_runner.669953  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/tshh/002759/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk0/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.lz4_compression-COMPRESSION.=.lz4/cluster/kikimr_configs"
2025-11-21 20:42:55,330 - INFO - ydb.tests.library.harness.kikimr_runner.669953  - __make_run_command: Final command: /home/runner/.ya/build/build_root/tshh/002759/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/tshh/002759/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk0/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.lz4_compression-COMPRESSION.=.lz4/cluster/node_1/logfile_l70ox7z9.log --grpc-port=6190 --mon-port=1274 --ic-port=19178
2025-11-21 20:42:55,331 - DEBUG - ydb.tests.library.harness.kikimr_runner.669953  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:6190/1, disk_size 68719476736
2025-11-21 20:42:55,331 - INFO - ydb.tests.library.harness.kikimr_runner.669953  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/tshh/002759/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk0/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.lz4_compression-COMPRESSION.=.lz4/cluster/kikimr_configs"
2025-11-21 20:42:55,331 - INFO - ydb.tests.library.harness.kikimr_runner.669953  - __make_run_command: Final command: /home/runner/.ya/build/build_root/tshh/002759/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/tshh/002759/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk0/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.lz4_compression-COMPRESSION.=.lz4/cluster/node_1/logfile_l70ox7z9.log --grpc-port=6190 --mon-port=1274 --ic-port=19178
2025-11-21 20:42:55,332 - DEBUG - ya.test.669953  - execute: Executing '('/home/runner/.ya/build/build_root/tshh/002759/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/tshh/002759/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk0/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.lz4_compression-COMPRESSION.=.lz4/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/tshh/002759/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk0/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.lz4_compression-COMPRESSION.=.lz4/cluster/node_1/logfile_l70ox7z9.log', '--grpc-port=6190', '--mon-port=1274', '--ic-port=19178')' in '/home/runner/.ya/build/build_root/tshh/002759/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk0/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.lz4_compression-COMPRESSION.=.lz4/cluster/node_1' (no wait)
2025-11-21 20:42:55,336 - DEBUG - ya.test.669953  - execute: Command pid: 673154
2025-11-21 20:42:55,337 - INFO - ydb.tests.library.harness.kikimr_runner.669953  - start: Started node localhost:6190/1
2025-11-21 20:42:55,339 - DEBUG - ya.test.669953  - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-21 20:42:55,339 - DEBUG - ya.test.669953  - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-21 20:42:55,340 - DEBUG - ya.test.669953  - execute: Executing '['/home/runner/.ya/build/build_root/tshh/002759/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-21 20:42:55,342 - DEBUG - ya.test.669953  - execute: Command pid: 673156
2025-11-21 20:42:56,159 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 673156) rc: 0
2025-11-21 20:42:56,159 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 673156) elapsed time (sec): 0.816352367401123
2025-11-21 20:42:56,159 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 673156) idrss: 0
2025-11-21 20:42:56,160 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 673156) inblock: 0
2025-11-21 20:42:56,160 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 673156) isrss: 0
2025-11-21 20:42:56,160 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 673156) ixrss: 0
2025-11-21 20:42:56,160 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 673156) majflt: 0
2025-11-21 20:42:56,161 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 673156) maxrss: 502008
2025-11-21 20:42:56,161 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 673156) minflt: 45589
2025-11-21 20:42:56,161 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 673156) msgrcv: 0
2025-11-21 20:42:56,161 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 673156) msgsnd: 0
2025-11-21 20:42:56,162 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 673156) nivcsw: 107
2025-11-21 20:42:56,163 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 673156) nsignals: 0
2025-11-21 20:42:56,163 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 673156) nswap: 0
2025-11-21 20:42:56,164 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 673156) nvcsw: 14
2025-11-21 20:42:56,164 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 673156) oublock: 8
2025-11-21 20:42:56,164 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 673156) stime: 0.176125
2025-11-21 20:42:56,164 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 673156) utime: 0.5308809999999999
2025-11-21 20:42:56,165 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 673156) wtime: 0.818
2025-11-21 20:42:56,165 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 673156) 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-frzglb4yoy    Host information: 
        Linux ghrun-frzglb4yoy 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 20:42:56,165 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 673156) errors:

2025-11-21 20:42:56,166 - INFO - ydb.tests.library.harness.kikimr_runner.669953  - 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-frzglb4yoy    Host information: 
        Linux ghrun-frzglb4yoy 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64
2025-11-21 20:43:01,090 - DEBUG - ya.test.669953  - get_binary: Binary was found by /home/runner/.ya/build/build_root/tshh/002759/ydb/apps/ydbd/ydbd
2025-11-21 20:43:01,099 - DEBUG - ydb.tests.library.harness.kikimr_runner.669953  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/tshh/002759/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:6190', '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: 19178\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-21 20:43:01,101 - DEBUG - ya.test.669953  - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-21 20:43:01,101 - DEBUG - ya.test.669953  - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-21 20:43:01,102 - DEBUG - ya.test.669953  - execute: Executing '['/home/runner/.ya/build/build_root/tshh/002759/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:6190', '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: 19178\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-21 20:43:01,124 - DEBUG - ya.test.669953  - execute: Command pid: 677252
2025-11-21 20:43:02,123 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677252) rc: 0
2025-11-21 20:43:02,123 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677252) elapsed time (sec): 0.9977898597717285
2025-11-21 20:43:02,124 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677252) idrss: 0
2025-11-21 20:43:02,124 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677252) inblock: 0
2025-11-21 20:43:02,124 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677252) isrss: 0
2025-11-21 20:43:02,124 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677252) ixrss: 0
2025-11-21 20:43:02,125 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677252) majflt: 0
2025-11-21 20:43:02,125 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677252) maxrss: 600932
2025-11-21 20:43:02,125 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677252) minflt: 52060
2025-11-21 20:43:02,125 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677252) msgrcv: 0
2025-11-21 20:43:02,126 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677252) msgsnd: 0
2025-11-21 20:43:02,126 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677252) nivcsw: 146
2025-11-21 20:43:02,126 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677252) nsignals: 0
2025-11-21 20:43:02,126 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677252) nswap: 0
2025-11-21 20:43:02,127 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677252) nvcsw: 388
2025-11-21 20:43:02,127 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677252) oublock: 8
2025-11-21 20:43:02,127 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677252) stime: 0.24792199999999998
2025-11-21 20:43:02,128 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677252) utime: 0.595001
2025-11-21 20:43:02,128 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677252) wtime: 1.02
2025-11-21 20:43:02,128 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677252) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-21 20:43:02,128 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677252) errors:

2025-11-21 20:43:02,130 - DEBUG - ya.test.669953  - get_binary: Binary was found by /home/runner/.ya/build/build_root/tshh/002759/ydb/apps/ydbd/ydbd
2025-11-21 20:43:02,130 - DEBUG - ydb.tests.library.harness.kikimr_runner.669953  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/tshh/002759/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:6190', '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 20:43:02,131 - DEBUG - ya.test.669953  - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-21 20:43:02,132 - DEBUG - ya.test.669953  - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-21 20:43:02,133 - DEBUG - ya.test.669953  - execute: Executing '['/home/runner/.ya/build/build_root/tshh/002759/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:6190', '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 20:43:02,134 - DEBUG - ya.test.669953  - execute: Command pid: 677888
2025-11-21 20:43:03,061 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677888) rc: 0
2025-11-21 20:43:03,061 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677888) elapsed time (sec): 0.9258613586425781
2025-11-21 20:43:03,062 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677888) idrss: 0
2025-11-21 20:43:03,062 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677888) inblock: 0
2025-11-21 20:43:03,062 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677888) isrss: 0
2025-11-21 20:43:03,062 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677888) ixrss: 0
2025-11-21 20:43:03,063 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677888) majflt: 0
2025-11-21 20:43:03,063 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677888) maxrss: 601184
2025-11-21 20:43:03,063 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677888) minflt: 51878
2025-11-21 20:43:03,063 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677888) msgrcv: 0
2025-11-21 20:43:03,064 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677888) msgsnd: 0
2025-11-21 20:43:03,064 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677888) nivcsw: 142
2025-11-21 20:43:03,064 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677888) nsignals: 0
2025-11-21 20:43:03,064 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677888) nswap: 0
2025-11-21 20:43:03,064 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677888) nvcsw: 875
2025-11-21 20:43:03,065 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677888) oublock: 8
2025-11-21 20:43:03,065 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677888) stime: 0.277831
2025-11-21 20:43:03,065 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677888) utime: 0.516609
2025-11-21 20:43:03,065 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677888) wtime: 0.927
2025-11-21 20:43:03,065 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677888) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-11-21 20:43:03,065 - DEBUG - ya.test.669953  - _save_outputs: Command (pid 677888) errors:

2025-11-21 20:43:03,066 - INFO - ydb.tests.library.harness.kikimr_runner.669953  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-21 20:43:03,131 - INFO - ydb.tests.library.harness.kikimr_runner.669953  - __run: Cluster started and initialized
2025-11-21 20:43:03,183 - DEBUG - ydb.connection.669953  - 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 20:43:03,186 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.669953  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-21 20:43:03,187 - DEBUG - ydb.connection.669953  - 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 20:43:03,203 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.669953  - context_resolve: Resolving endpoints for database /Root
2025-11-21 20:43:03,204 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ListEndpoints, cfd33062-408c-4617-9e5d-3848690620fe, localhost:6190): creating call state
2025-11-21 20:43:03,204 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ListEndpoints, cfd33062-408c-4617-9e5d-3848690620fe, localhost:6190): request = { database: "/Root" }
2025-11-21 20:43:03,218 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ListEndpoints, cfd33062-408c-4617-9e5d-3848690620fe, localhost:6190): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-frzglb4yoy.auto.internal" port: 6190 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 20:43:03,219 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.669953  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-frzglb4yoy.auto.internal:6190, location 1, ssl: False>]>
2025-11-21 20:43:03,220 - DEBUG - ydb.connection.669953  - 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 20:43:03,233 - DEBUG - ydb.connection.669953  - close: Closing channel for endpoint localhost:6190
2025-11-21 20:43:03,233 - DEBUG - ydb.query.pool.669953  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-21 20:43:03,235 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(CreateSession, 20f60282-f34f-4d3e-af5c-94c28c1c91c4, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:03,235 - DEBUG - ydb.connection.669953  - _log_request: RpcState(CreateSession, 20f60282-f34f-4d3e-af5c-94c28c1c91c4, ghrun-frzglb4yoy.auto.internal:6190): request = {  }
2025-11-21 20:43:03,243 - DEBUG - ydb.connection.669953  - _log_response: RpcState(CreateSession, 20f60282-f34f-4d3e-af5c-94c28c1c91c4, ghrun-frzglb4yoy.auto.internal:6190): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" node_id: 1 }
2025-11-21 20:43:03,244 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(AttachSession, f71dfc0f-4a3d-49ac-a084-a242d15b26e2, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:03,245 - DEBUG - ydb.connection.669953  - _log_request: RpcState(AttachSession, f71dfc0f-4a3d-49ac-a084-a242d15b26e2, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" }
2025-11-21 20:43:03,251 - DEBUG - ydb.connection.669953  - _log_response: RpcState(AttachSession, f71dfc0f-4a3d-49ac-a084-a242d15b26e2, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:03,268 - DEBUG - ydb.query.pool.669953  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:03,269 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, d599eb89-fa92-4227-9839-8945348731d2, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:03,270 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, d599eb89-fa92-4227-9839-8945348731d2, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:03,271 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, d599eb89-fa92-4227-9839-8945348731d2, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:05,583 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:05,584 - INFO - __tests__.alter_compression.669953  - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-11-21 20:43:05,584 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:05,585 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 777f7229-fdc5-432b-a525-d3c684f73cae, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:05,586 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 777f7229-fdc5-432b-a525-d3c684f73cae, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:05,587 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 777f7229-fdc5-432b-a525-d3c684f73cae, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:06,502 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:06,503 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:06,503 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, d0a2cae0-41fb-4550-ac73-dfd4672e9800, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:06,505 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, d0a2cae0-41fb-4550-ac73-dfd4672e9800, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:06,506 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, d0a2cae0-41fb-4550-ac73-dfd4672e9800, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:07,331 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:07,331 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:07,332 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 709b763c-c712-4e6d-b441-5577dbdd8236, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:07,333 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 709b763c-c712-4e6d-b441-5577dbdd8236, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:07,334 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 709b763c-c712-4e6d-b441-5577dbdd8236, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:08,076 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:08,077 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:08,078 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 374c5e70-639a-4f29-87a5-8c4156ca180e, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:08,079 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 374c5e70-639a-4f29-87a5-8c4156ca180e, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:08,080 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 374c5e70-639a-4f29-87a5-8c4156ca180e, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:09,332 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:09,333 - INFO - __tests__.alter_compression.669953  - 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 20:43:09,333 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:09,334 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 0b69a6d3-1932-4486-8e78-da9c056300ee, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:09,335 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 0b69a6d3-1932-4486-8e78-da9c056300ee, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:09,336 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 0b69a6d3-1932-4486-8e78-da9c056300ee, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:10,045 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:10,046 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:10,047 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 553178b5-694f-44a0-92c8-dc5a80a31cce, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:10,047 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 553178b5-694f-44a0-92c8-dc5a80a31cce, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:10,049 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 553178b5-694f-44a0-92c8-dc5a80a31cce, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:10,197 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:10,198 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:10,199 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, f80abfb7-3252-4f71-bf4c-b5a5645c6c7f, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:10,199 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, f80abfb7-3252-4f71-bf4c-b5a5645c6c7f, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:10,204 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, f80abfb7-3252-4f71-bf4c-b5a5645c6c7f, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:10,411 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:10,412 - INFO - __tests__.alter_compression.669953  - 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 20:43:10,413 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:10,414 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 8faa6ca1-e284-4f7c-bb59-be68ccf59296, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:10,415 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 8faa6ca1-e284-4f7c-bb59-be68ccf59296, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:10,417 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 8faa6ca1-e284-4f7c-bb59-be68ccf59296, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:11,204 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:11,205 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:11,205 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, e850cc0f-8769-4e5e-aef6-6b628c27432e, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:11,206 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, e850cc0f-8769-4e5e-aef6-6b628c27432e, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:11,210 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, e850cc0f-8769-4e5e-aef6-6b628c27432e, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:11,375 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:11,375 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:11,376 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 15ebf8eb-ac22-415e-a5ea-e8d5a0c25410, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:11,377 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 15ebf8eb-ac22-415e-a5ea-e8d5a0c25410, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:11,378 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 15ebf8eb-ac22-415e-a5ea-e8d5a0c25410, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:11,721 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:11,722 - INFO - __tests__.alter_compression.669953  - 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 20:43:11,722 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:11,723 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 77c6ba06-47aa-4617-9733-3bcce50654f2, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:11,724 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 77c6ba06-47aa-4617-9733-3bcce50654f2, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:11,726 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 77c6ba06-47aa-4617-9733-3bcce50654f2, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:12,598 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:12,599 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:12,600 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, ccfe4ee7-112e-41e4-8dd1-b5a97b4336d4, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:12,600 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, ccfe4ee7-112e-41e4-8dd1-b5a97b4336d4, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:12,602 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, ccfe4ee7-112e-41e4-8dd1-b5a97b4336d4, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:12,806 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:12,807 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:12,808 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 5f56dddf-203b-47c6-aae2-e9b8d40c3289, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:12,809 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 5f56dddf-203b-47c6-aae2-e9b8d40c3289, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:12,810 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 5f56dddf-203b-47c6-aae2-e9b8d40c3289, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:13,458 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:13,459 - INFO - __tests__.alter_compression.669953  - 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 20:43:13,459 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:13,460 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, e52c27b7-71f3-4883-bbef-40fb7af34df9, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:13,461 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, e52c27b7-71f3-4883-bbef-40fb7af34df9, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:13,462 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, e52c27b7-71f3-4883-bbef-40fb7af34df9, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:14,292 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:14,293 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:14,294 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 3f509dfc-5b01-4a97-8630-fb2fb1d2f9a9, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:14,294 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 3f509dfc-5b01-4a97-8630-fb2fb1d2f9a9, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:14,295 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 3f509dfc-5b01-4a97-8630-fb2fb1d2f9a9, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:14,478 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:14,478 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:14,479 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 68dd967a-b08b-4b2a-a34f-bf2437a1e782, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:14,480 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 68dd967a-b08b-4b2a-a34f-bf2437a1e782, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:14,481 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 68dd967a-b08b-4b2a-a34f-bf2437a1e782, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:14,774 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:14,775 - INFO - __tests__.alter_compression.669953  - 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 20:43:14,775 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:14,776 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, bfb0d8d9-beeb-46e4-ad7e-85c38b9ba427, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:14,777 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, bfb0d8d9-beeb-46e4-ad7e-85c38b9ba427, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:14,778 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, bfb0d8d9-beeb-46e4-ad7e-85c38b9ba427, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:15,630 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:15,631 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:15,632 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, dacf2396-146b-47d7-99cc-f0a7ddb86433, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:15,632 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, dacf2396-146b-47d7-99cc-f0a7ddb86433, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:15,634 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, dacf2396-146b-47d7-99cc-f0a7ddb86433, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:15,815 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:15,816 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:15,816 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 07976b3d-cfdf-4fb8-925b-c79dfcf4183b, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:15,817 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 07976b3d-cfdf-4fb8-925b-c79dfcf4183b, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:15,819 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 07976b3d-cfdf-4fb8-925b-c79dfcf4183b, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:16,216 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:16,217 - INFO - __tests__.alter_compression.669953  - 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 20:43:16,217 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:16,217 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, f950c899-eaf4-49d5-8e0d-f78c3bd55f48, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:16,218 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, f950c899-eaf4-49d5-8e0d-f78c3bd55f48, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:16,219 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, f950c899-eaf4-49d5-8e0d-f78c3bd55f48, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:17,004 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:17,005 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:17,006 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 8e5c68f4-8e10-4cdc-8ba1-5fc058290189, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:17,007 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 8e5c68f4-8e10-4cdc-8ba1-5fc058290189, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:17,009 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 8e5c68f4-8e10-4cdc-8ba1-5fc058290189, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:17,185 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:17,186 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:17,187 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 681107f5-e0e2-4975-9902-75251985ec55, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:17,188 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 681107f5-e0e2-4975-9902-75251985ec55, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:17,189 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 681107f5-e0e2-4975-9902-75251985ec55, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:17,615 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:17,616 - INFO - __tests__.alter_compression.669953  - 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 20:43:17,617 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:17,618 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, adba20e5-c12f-4c81-b8a5-07481279c256, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:17,619 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, adba20e5-c12f-4c81-b8a5-07481279c256, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:17,620 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, adba20e5-c12f-4c81-b8a5-07481279c256, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:18,515 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:18,516 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:18,516 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 7e34752d-b06a-47e9-bf31-bfc24738da10, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:18,517 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 7e34752d-b06a-47e9-bf31-bfc24738da10, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:18,519 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 7e34752d-b06a-47e9-bf31-bfc24738da10, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:18,681 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:18,681 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:18,682 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, bb07f0ec-7c0e-4156-9457-9c72ed691c52, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:18,683 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, bb07f0ec-7c0e-4156-9457-9c72ed691c52, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:18,685 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, bb07f0ec-7c0e-4156-9457-9c72ed691c52, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:19,179 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:19,180 - INFO - __tests__.alter_compression.669953  - 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 20:43:19,180 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:19,181 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 65df8d81-19c9-46c8-abab-4843c2805960, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:19,182 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 65df8d81-19c9-46c8-abab-4843c2805960, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:19,185 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 65df8d81-19c9-46c8-abab-4843c2805960, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:19,951 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:19,952 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:19,952 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 48a6c2d9-14a1-4c69-88f7-7160aaedc192, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:19,953 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 48a6c2d9-14a1-4c69-88f7-7160aaedc192, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:19,955 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 48a6c2d9-14a1-4c69-88f7-7160aaedc192, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:20,156 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:20,156 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:20,157 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 33b01688-794a-4481-95ed-93698d5ed8c2, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:20,158 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 33b01688-794a-4481-95ed-93698d5ed8c2, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:20,159 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 33b01688-794a-4481-95ed-93698d5ed8c2, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:20,635 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:20,635 - INFO - __tests__.alter_compression.669953  - 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 20:43:20,636 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:20,637 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 7575fca0-4945-4691-97dd-5e9f873a0528, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:20,638 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 7575fca0-4945-4691-97dd-5e9f873a0528, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:20,640 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 7575fca0-4945-4691-97dd-5e9f873a0528, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:21,499 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:21,500 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:21,501 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 8aa6ae77-861f-472c-b8cf-b384b55df705, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:21,501 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 8aa6ae77-861f-472c-b8cf-b384b55df705, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:21,507 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 8aa6ae77-861f-472c-b8cf-b384b55df705, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:21,707 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:21,707 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:21,708 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 1fa5098e-0746-4552-b42e-096a53359e80, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:21,709 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 1fa5098e-0746-4552-b42e-096a53359e80, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:21,710 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 1fa5098e-0746-4552-b42e-096a53359e80, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:22,285 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:22,286 - INFO - __tests__.alter_compression.669953  - 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 20:43:22,286 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:22,287 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, e5735f70-454c-4af8-a6de-c9bcf81f8f6e, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:22,288 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, e5735f70-454c-4af8-a6de-c9bcf81f8f6e, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:22,289 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, e5735f70-454c-4af8-a6de-c9bcf81f8f6e, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:23,140 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:23,141 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:23,142 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 8ae0df2f-057a-47ab-aa6a-2f3c638d0248, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:23,142 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 8ae0df2f-057a-47ab-aa6a-2f3c638d0248, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:23,143 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 8ae0df2f-057a-47ab-aa6a-2f3c638d0248, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:23,358 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:23,359 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:23,359 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, bbe5d245-bbee-46c0-899d-f7db3a4f050a, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:23,360 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, bbe5d245-bbee-46c0-899d-f7db3a4f050a, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:23,362 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, bbe5d245-bbee-46c0-899d-f7db3a4f050a, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:23,571 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:23,572 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:23,573 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 5d22e47d-0acf-4876-bebc-b6f268bf71e7, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:23,574 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 5d22e47d-0acf-4876-bebc-b6f268bf71e7, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:23,575 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 5d22e47d-0acf-4876-bebc-b6f268bf71e7, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:26,909 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:36,953 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:36,954 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 79f92814-5d76-4bf5-ba86-7097b4569fa3, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:36,955 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 79f92814-5d76-4bf5-ba86-7097b4569fa3, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:36,956 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 79f92814-5d76-4bf5-ba86-7097b4569fa3, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:39,505 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:39,542 - INFO - root.669953  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-21 20:43:39,543 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:39,544 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, f1a0dbca-560f-48a7-9d07-df77693d21da, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:39,544 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, f1a0dbca-560f-48a7-9d07-df77693d21da, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:39,545 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, f1a0dbca-560f-48a7-9d07-df77693d21da, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:42,178 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:52,228 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:52,229 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, b3c934ce-6796-4262-89ac-d7b9a0e6a06b, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:52,230 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, b3c934ce-6796-4262-89ac-d7b9a0e6a06b, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:52,231 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, b3c934ce-6796-4262-89ac-d7b9a0e6a06b, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:54,667 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:54,708 - INFO - root.669953  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-21 20:43:54,709 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:54,710 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, d57c66c8-83b1-4819-b951-ff5f88d3b3dd, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:54,711 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, d57c66c8-83b1-4819-b951-ff5f88d3b3dd, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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 20:43:54,712 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, d57c66c8-83b1-4819-b951-ff5f88d3b3dd, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:54,950 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:54,953 - INFO - ya.test.669953  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[lz4_compression-COMPRESSION = "lz4"])
2025-11-21 20:43:54,954 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:54,956 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, d8725918-c964-427f-b111-5de6e08a5f55, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:54,957 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, d8725918-c964-427f-b111-5de6e08a5f55, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/lz4_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"lz4\")\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:54,958 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, d8725918-c964-427f-b111-5de6e08a5f55, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:57,284 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:57,284 - INFO - __tests__.alter_compression.669953  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/lz4_compression created
2025-11-21 20:43:57,285 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:57,285 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 7fe44de4-498d-418f-b895-f5c968f0578e, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:57,286 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 7fe44de4-498d-418f-b895-f5c968f0578e, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/lz4_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:57,287 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 7fe44de4-498d-418f-b895-f5c968f0578e, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:58,055 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:58,056 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:58,057 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 0f6a0a68-d068-4cca-826a-1a4484610c3c, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:58,084 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 0f6a0a68-d068-4cca-826a-1a4484610c3c, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:58,086 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 0f6a0a68-d068-4cca-826a-1a4484610c3c, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:59,051 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:59,051 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:59,052 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 20b7a28b-3737-435f-90e8-d5cf1f6c5fc6, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:59,053 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 20b7a28b-3737-435f-90e8-d5cf1f6c5fc6, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:59,054 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 20b7a28b-3737-435f-90e8-d5cf1f6c5fc6, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:59,821 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:59,821 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:43:59,822 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, cb2a1c74-86f8-4a47-94a8-6f68ddf332b3, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:43:59,823 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, cb2a1c74-86f8-4a47-94a8-6f68ddf332b3, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:59,824 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, cb2a1c74-86f8-4a47-94a8-6f68ddf332b3, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:01,204 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:01,205 - INFO - __tests__.alter_compression.669953  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/lz4_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 872992, 'BlobCount': 128}}
2025-11-21 20:44:01,205 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:01,206 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, ea870d90-146a-44c3-bb23-9c6a344e159a, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:01,208 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, ea870d90-146a-44c3-bb23-9c6a344e159a, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:01,210 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, ea870d90-146a-44c3-bb23-9c6a344e159a, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:02,203 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:02,204 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:02,204 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 4db443fb-9cd7-42dc-bc94-b8720e118dff, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:02,205 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 4db443fb-9cd7-42dc-bc94-b8720e118dff, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:02,206 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 4db443fb-9cd7-42dc-bc94-b8720e118dff, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:02,479 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:02,480 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:02,481 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, aa4cd4b7-0890-4ff7-ad95-b26edc0f6bf9, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:02,482 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, aa4cd4b7-0890-4ff7-ad95-b26edc0f6bf9, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:02,485 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, aa4cd4b7-0890-4ff7-ad95-b26edc0f6bf9, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:02,823 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:02,824 - INFO - __tests__.alter_compression.669953  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/lz4_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 1747088, 'BlobCount': 256}}
2025-11-21 20:44:02,824 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:02,825 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 90055eb1-c2ce-42c3-985e-00a48f5e4ebf, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:02,826 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 90055eb1-c2ce-42c3-985e-00a48f5e4ebf, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:02,829 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 90055eb1-c2ce-42c3-985e-00a48f5e4ebf, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:03,939 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:03,940 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:03,940 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 8c1ea424-3762-49d6-aea6-15c54bdd411b, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:03,941 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 8c1ea424-3762-49d6-aea6-15c54bdd411b, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:03,943 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 8c1ea424-3762-49d6-aea6-15c54bdd411b, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:04,215 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:04,216 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:04,217 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 4c22bd69-9d54-4130-b3c3-e6538efe9981, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:04,218 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 4c22bd69-9d54-4130-b3c3-e6538efe9981, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:04,219 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 4c22bd69-9d54-4130-b3c3-e6538efe9981, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:04,655 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:04,656 - INFO - __tests__.alter_compression.669953  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/lz4_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 2620992, 'BlobCount': 384}}
2025-11-21 20:44:04,657 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:04,657 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 5ef102a2-cef7-408c-bf66-d6610ff53827, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:04,658 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 5ef102a2-cef7-408c-bf66-d6610ff53827, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:04,664 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 5ef102a2-cef7-408c-bf66-d6610ff53827, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:06,054 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:06,054 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:06,055 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 94a7b816-73e6-4937-a5fd-4dc9ba9c3b42, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:06,056 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 94a7b816-73e6-4937-a5fd-4dc9ba9c3b42, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:06,057 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 94a7b816-73e6-4937-a5fd-4dc9ba9c3b42, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:06,376 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:06,377 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:06,378 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 88e9a9ae-4633-4fe5-b5ed-82279b0b1239, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:06,379 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 88e9a9ae-4633-4fe5-b5ed-82279b0b1239, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:06,380 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 88e9a9ae-4633-4fe5-b5ed-82279b0b1239, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:06,973 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:06,974 - INFO - __tests__.alter_compression.669953  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/lz4_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 3495088, 'BlobCount': 512}}
2025-11-21 20:44:06,974 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:06,975 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 8e3895a1-2b13-4617-b8e6-afd21ac4eb11, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:06,976 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 8e3895a1-2b13-4617-b8e6-afd21ac4eb11, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:06,979 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 8e3895a1-2b13-4617-b8e6-afd21ac4eb11, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:08,017 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:08,018 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:08,018 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 771e65fe-5477-4bb4-bd2e-29ad75995701, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:08,019 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 771e65fe-5477-4bb4-bd2e-29ad75995701, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:08,020 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 771e65fe-5477-4bb4-bd2e-29ad75995701, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:08,347 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:08,348 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:08,349 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 9e3ff4a7-9a00-486f-8416-9e2d96cf5237, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:08,350 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 9e3ff4a7-9a00-486f-8416-9e2d96cf5237, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:08,351 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 9e3ff4a7-9a00-486f-8416-9e2d96cf5237, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:09,004 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:09,005 - INFO - __tests__.alter_compression.669953  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/lz4_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 4368976, 'BlobCount': 640}}
2025-11-21 20:44:09,005 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:09,006 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 0a10d43a-f4b2-48b5-be8e-1d1f4511325f, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:09,007 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 0a10d43a-f4b2-48b5-be8e-1d1f4511325f, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:09,008 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 0a10d43a-f4b2-48b5-be8e-1d1f4511325f, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:09,954 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:09,954 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:09,955 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, c7fedb59-30e5-41c9-b15c-519a0c0f0bf4, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:09,956 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, c7fedb59-30e5-41c9-b15c-519a0c0f0bf4, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:09,957 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, c7fedb59-30e5-41c9-b15c-519a0c0f0bf4, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:10,256 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:10,257 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:10,258 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 239f304f-9232-4b66-8aed-af0a624e9f46, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:10,259 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 239f304f-9232-4b66-8aed-af0a624e9f46, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:10,260 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 239f304f-9232-4b66-8aed-af0a624e9f46, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:10,892 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:10,893 - INFO - __tests__.alter_compression.669953  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/lz4_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 5242960, 'BlobCount': 768}}
2025-11-21 20:44:10,893 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:10,894 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 99829ae1-3a3c-489d-9d4f-36c85acca8f0, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:10,895 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 99829ae1-3a3c-489d-9d4f-36c85acca8f0, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:10,896 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 99829ae1-3a3c-489d-9d4f-36c85acca8f0, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:11,942 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:11,942 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:11,943 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 4e07b2bd-31b9-4deb-a2c4-2f25c000ee54, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:11,944 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 4e07b2bd-31b9-4deb-a2c4-2f25c000ee54, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:11,945 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 4e07b2bd-31b9-4deb-a2c4-2f25c000ee54, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:12,315 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:12,316 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:12,317 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, aa86746e-616d-4924-8491-0f810ebe3cc1, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:12,318 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, aa86746e-616d-4924-8491-0f810ebe3cc1, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:12,319 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, aa86746e-616d-4924-8491-0f810ebe3cc1, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:12,920 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:12,921 - INFO - __tests__.alter_compression.669953  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/lz4_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 6117040, 'BlobCount': 896}}
2025-11-21 20:44:12,921 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:12,922 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, b3588e3a-bfde-4a2b-89e9-145d8dce7aa6, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:12,923 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, b3588e3a-bfde-4a2b-89e9-145d8dce7aa6, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:12,925 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, b3588e3a-bfde-4a2b-89e9-145d8dce7aa6, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:13,953 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:13,954 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:13,955 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, da33169d-712b-4d30-b22c-8c5c28f82f59, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:13,956 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, da33169d-712b-4d30-b22c-8c5c28f82f59, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:13,959 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, da33169d-712b-4d30-b22c-8c5c28f82f59, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:14,231 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:14,232 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:14,232 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 16cb09e6-beef-47c1-84b3-50be0eaf6392, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:14,233 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 16cb09e6-beef-47c1-84b3-50be0eaf6392, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:14,236 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 16cb09e6-beef-47c1-84b3-50be0eaf6392, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:14,927 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:14,928 - INFO - __tests__.alter_compression.669953  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/lz4_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 6991184, 'BlobCount': 1024}}
2025-11-21 20:44:14,928 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:14,929 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, d70fb6cc-8ef4-4e70-8a59-fa99cb49c565, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:14,930 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, d70fb6cc-8ef4-4e70-8a59-fa99cb49c565, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:14,931 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, d70fb6cc-8ef4-4e70-8a59-fa99cb49c565, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:15,921 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:15,922 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:15,923 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 9c7dac6e-d8e2-4bdb-b80d-fbcb3787f4c5, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:15,923 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 9c7dac6e-d8e2-4bdb-b80d-fbcb3787f4c5, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:15,925 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 9c7dac6e-d8e2-4bdb-b80d-fbcb3787f4c5, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:16,246 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:16,246 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:16,247 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 5e307ab3-0638-46ac-80ff-00932e345709, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:16,248 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 5e307ab3-0638-46ac-80ff-00932e345709, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:16,250 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 5e307ab3-0638-46ac-80ff-00932e345709, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:16,935 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:16,936 - INFO - __tests__.alter_compression.669953  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/lz4_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 7865088, 'BlobCount': 1152}}
2025-11-21 20:44:16,936 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:16,936 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, aafafd53-65f8-482a-be3b-2fe76cacfc08, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:16,937 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, aafafd53-65f8-482a-be3b-2fe76cacfc08, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:16,938 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, aafafd53-65f8-482a-be3b-2fe76cacfc08, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:17,929 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:17,930 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:17,931 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 6352c048-b9da-4388-a667-6b7f8b870dbf, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:17,932 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 6352c048-b9da-4388-a667-6b7f8b870dbf, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:17,934 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 6352c048-b9da-4388-a667-6b7f8b870dbf, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:18,168 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:18,169 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:18,170 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 5e02ec7c-8e9c-44bf-8bb2-0672ad2a20e1, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:18,171 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 5e02ec7c-8e9c-44bf-8bb2-0672ad2a20e1, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:18,172 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 5e02ec7c-8e9c-44bf-8bb2-0672ad2a20e1, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:18,804 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:18,805 - INFO - __tests__.alter_compression.669953  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/lz4_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 8739264, 'BlobCount': 1280}}
2025-11-21 20:44:18,806 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:18,806 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 28ef96bc-c949-499c-ac5d-23105568788a, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:18,807 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 28ef96bc-c949-499c-ac5d-23105568788a, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/lz4_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:18,809 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 28ef96bc-c949-499c-ac5d-23105568788a, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:19,912 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:19,913 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:19,914 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, c2df6357-998a-443a-9b2b-a5de40a5cc39, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:19,915 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, c2df6357-998a-443a-9b2b-a5de40a5cc39, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:19,917 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, c2df6357-998a-443a-9b2b-a5de40a5cc39, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:20,197 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:20,197 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:20,198 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 7dfa9c71-c23d-4e45-8abf-351ee1093f89, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:20,199 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 7dfa9c71-c23d-4e45-8abf-351ee1093f89, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:20,200 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 7dfa9c71-c23d-4e45-8abf-351ee1093f89, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:20,521 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:20,522 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:20,523 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 90546fe5-3604-4fa4-8b91-bfbf966a7023, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:20,523 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 90546fe5-3604-4fa4-8b91-bfbf966a7023, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/lz4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:20,525 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 90546fe5-3604-4fa4-8b91-bfbf966a7023, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:23,909 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:33,959 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:33,960 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 5cc058b5-1bc3-4e1f-a4e4-7b9343b35251, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:33,961 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 5cc058b5-1bc3-4e1f-a4e4-7b9343b35251, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/lz4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:33,962 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 5cc058b5-1bc3-4e1f-a4e4-7b9343b35251, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:40,197 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:40,260 - INFO - root.669953  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/lz4_compression`, volumes `value` (8000000, 4369632)
2025-11-21 20:44:40,261 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:40,262 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 3ae250ad-6a84-4a5b-9115-6d35ed8773bb, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:40,262 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 3ae250ad-6a84-4a5b-9115-6d35ed8773bb, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" 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/lz4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:40,264 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 3ae250ad-6a84-4a5b-9115-6d35ed8773bb, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:40,836 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:40,837 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:40,838 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 15a08ea9-5cb8-4b2f-b17e-59d8fc1dba72, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:40,838 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 15a08ea9-5cb8-4b2f-b17e-59d8fc1dba72, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/lz4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:40,840 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 15a08ea9-5cb8-4b2f-b17e-59d8fc1dba72, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:45,254 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:55,303 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:44:55,304 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 279e489c-3dec-4a0b-89c7-013379aba875, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:44:55,305 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 279e489c-3dec-4a0b-89c7-013379aba875, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/lz4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:55,306 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 279e489c-3dec-4a0b-89c7-013379aba875, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:58,558 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.669953  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-21 20:44:58,560 - DEBUG - ydb.connection.669953  - 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 20:44:58,628 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.669953  - context_resolve: Resolving endpoints for database /Root
2025-11-21 20:44:58,628 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ListEndpoints, 73e8d916-5082-4a6d-ac41-7fc04c791962, localhost:6190): creating call state
2025-11-21 20:44:58,629 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ListEndpoints, 73e8d916-5082-4a6d-ac41-7fc04c791962, localhost:6190): request = { database: "/Root" }
2025-11-21 20:44:58,646 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ListEndpoints, 73e8d916-5082-4a6d-ac41-7fc04c791962, localhost:6190): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-frzglb4yoy.auto.internal" port: 6190 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 20:44:58,647 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.669953  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-frzglb4yoy.auto.internal:6190, location 1, ssl: False>]>
2025-11-21 20:44:58,648 - DEBUG - ydb.connection.669953  - close: Closing channel for endpoint localhost:6190
2025-11-21 20:45:03,480 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:45:13,579 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:45:13,581 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, a14551e4-cc41-4b2c-bd30-4ddd4b930d57, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:45:13,581 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, a14551e4-cc41-4b2c-bd30-4ddd4b930d57, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/lz4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:45:13,583 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, a14551e4-cc41-4b2c-bd30-4ddd4b930d57, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:45:16,672 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:45:26,691 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:45:26,692 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, 16323526-4398-4c4b-9e8a-5b2aff6c387c, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:45:26,692 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, 16323526-4398-4c4b-9e8a-5b2aff6c387c, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/lz4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:45:26,694 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, 16323526-4398-4c4b-9e8a-5b2aff6c387c, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:45:28,528 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:45:38,532 - DEBUG - ydb.query.pool.669953  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:45:38,533 - DEBUG - ydb.connection.669953  - _prepare_call: RpcState(ExecuteQuery, da96b840-167a-4d82-a6d3-2233e79e2f8c, ghrun-frzglb4yoy.auto.internal:6190): creating call state
2025-11-21 20:45:38,534 - DEBUG - ydb.connection.669953  - _log_request: RpcState(ExecuteQuery, da96b840-167a-4d82-a6d3-2233e79e2f8c, ghrun-frzglb4yoy.auto.internal:6190): request = { session_id: "ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/lz4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:45:38,536 - DEBUG - ydb.connection.669953  - _log_response: RpcState(ExecuteQuery, da96b840-167a-4d82-a6d3-2233e79e2f8c, ghrun-frzglb4yoy.auto.internal:6190): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:45:40,170 - DEBUG - ydb.query.pool.669953  - release: Session returned to queue: ydb://session/3?node_id=1&id=MTUzMmIyMmUtNDg0OWFkMWMtOGVkNTJjOWYtNzMwZjFmYmM=
2025-11-21 20:45:40,174 - INFO - root.669953  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/lz4_compression`, volumes `value` (8000000, 4258592)
2025-11-21 20:45:40,174 - INFO - root.669953  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/lz4_compression` 8092160 / 4258592: 1.900196121159294
2025-11-21 20:45:40,185 - INFO - ya.test.669953  - pytest_runtest_teardown: Test teardown
