2025-10-31 14:31:48,453 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-31 14:31:48,454 - INFO - ya.test - pytest_runtest_setup: test_all_supported_compression[zstd_8_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 8]
2025-10-31 14:31:48,454 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-31 14:31:48,455 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-31 14:31:48,457 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-10-31 14:31:48,458 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-10-31 14:31:48,459 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/zwqj/0014b9/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-31 14:31:48,477 - DEBUG - ya.test - execute: Command pid: 1049666
2025-10-31 14:31:49,825 - DEBUG - ya.test - _save_outputs: Command (pid 1049666) rc: 0
2025-10-31 14:31:49,826 - DEBUG - ya.test - _save_outputs: Command (pid 1049666) elapsed time (sec): 1.346400499343872
2025-10-31 14:31:49,826 - DEBUG - ya.test - _save_outputs: Command (pid 1049666) idrss: 0
2025-10-31 14:31:49,827 - DEBUG - ya.test - _save_outputs: Command (pid 1049666) inblock: 0
2025-10-31 14:31:49,827 - DEBUG - ya.test - _save_outputs: Command (pid 1049666) isrss: 0
2025-10-31 14:31:49,827 - DEBUG - ya.test - _save_outputs: Command (pid 1049666) ixrss: 0
2025-10-31 14:31:49,828 - DEBUG - ya.test - _save_outputs: Command (pid 1049666) majflt: 0
2025-10-31 14:31:49,828 - DEBUG - ya.test - _save_outputs: Command (pid 1049666) maxrss: 481936
2025-10-31 14:31:49,828 - DEBUG - ya.test - _save_outputs: Command (pid 1049666) minflt: 45380
2025-10-31 14:31:49,829 - DEBUG - ya.test - _save_outputs: Command (pid 1049666) msgrcv: 0
2025-10-31 14:31:49,830 - DEBUG - ya.test - _save_outputs: Command (pid 1049666) msgsnd: 0
2025-10-31 14:31:49,830 - DEBUG - ya.test - _save_outputs: Command (pid 1049666) nivcsw: 222
2025-10-31 14:31:49,831 - DEBUG - ya.test - _save_outputs: Command (pid 1049666) nsignals: 0
2025-10-31 14:31:49,831 - DEBUG - ya.test - _save_outputs: Command (pid 1049666) nswap: 0
2025-10-31 14:31:49,831 - DEBUG - ya.test - _save_outputs: Command (pid 1049666) nvcsw: 14
2025-10-31 14:31:49,832 - DEBUG - ya.test - _save_outputs: Command (pid 1049666) oublock: 8
2025-10-31 14:31:49,832 - DEBUG - ya.test - _save_outputs: Command (pid 1049666) stime: 0.25489
2025-10-31 14:31:49,832 - DEBUG - ya.test - _save_outputs: Command (pid 1049666) utime: 0.538141
2025-10-31 14:31:49,841 - DEBUG - ya.test - _save_outputs: Command (pid 1049666) wtime: 1.365
2025-10-31 14:31:49,841 - DEBUG - ya.test - _save_outputs: Command (pid 1049666) output:
Git info:
    Commit: 81e21063d590ae7636d4475c58381f90e065d70f
    Branch: 
    Author: xyliganSereja <matva0509@gmail.com>
    Summary: Merge 4453e1bb1feb0e82a9049e95374936e29fc264d7 into d79725158e2f111172387151aa3fd9735997d399

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-uk32wjuvr4
    Host information: 
        Linux ghrun-uk32wjuvr4 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/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/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-10-31 14:31:49,842 - DEBUG - ya.test - _save_outputs: Command (pid 1049666) errors:

2025-10-31 14:31:49,842 - INFO - __tests__.base - _setup_ydb: Git info:
    Commit: 81e21063d590ae7636d4475c58381f90e065d70f
    Branch: 
    Author: xyliganSereja <matva0509@gmail.com>
    Summary: Merge 4453e1bb1feb0e82a9049e95374936e29fc264d7 into d79725158e2f111172387151aa3fd9735997d399

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-uk32wjuvr4
    Host information: 
        Linux ghrun-uk32wjuvr4 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/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/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-10-31 14:31:50,172 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/zwqj/0014b9/ydb/apps/ydbd/ydbd
2025-10-31 14:31:50,173 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/26579
2025-10-31 14:31:50,175 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/zwqj/0014b9/r3tmp/kikimr_cluster_maoex3x6
2025-10-31 14:31:50,227 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/zwqj/0014b9/ydb/apps/ydbd/ydbd
2025-10-31 14:31:50,228 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/10080
2025-10-31 14:31:50,229 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/28391
2025-10-31 14:31:50,229 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/26261
2025-10-31 14:31:50,230 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/24510
2025-10-31 14:31:50,231 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/zwqj/0014b9/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/kikimr_configs"
2025-10-31 14:31:50,232 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/zwqj/0014b9/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/zwqj/0014b9/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/node_1/logfile_48vexohd.log --grpc-port=10080 --mon-port=28391 --ic-port=26579
2025-10-31 14:31:50,232 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:10080/1, disk_size 68719476736
2025-10-31 14:31:50,233 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/zwqj/0014b9/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/kikimr_configs"
2025-10-31 14:31:50,233 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/zwqj/0014b9/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/zwqj/0014b9/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/node_1/logfile_48vexohd.log --grpc-port=10080 --mon-port=28391 --ic-port=26579
2025-10-31 14:31:50,234 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/zwqj/0014b9/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/zwqj/0014b9/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/zwqj/0014b9/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/node_1/logfile_48vexohd.log', '--grpc-port=10080', '--mon-port=28391', '--ic-port=26579')' in '/home/runner/.ya/build/build_root/zwqj/0014b9/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/node_1' (no wait)
2025-10-31 14:31:50,239 - DEBUG - ya.test - execute: Command pid: 1049996
2025-10-31 14:31:50,240 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:10080/1
2025-10-31 14:31:50,242 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-10-31 14:31:50,243 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-10-31 14:31:50,243 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/zwqj/0014b9/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-31 14:31:50,261 - DEBUG - ya.test - execute: Command pid: 1049998
2025-10-31 14:31:51,589 - DEBUG - ya.test - _save_outputs: Command (pid 1049998) rc: 0
2025-10-31 14:31:51,589 - DEBUG - ya.test - _save_outputs: Command (pid 1049998) elapsed time (sec): 1.326850414276123
2025-10-31 14:31:51,590 - DEBUG - ya.test - _save_outputs: Command (pid 1049998) idrss: 0
2025-10-31 14:31:51,590 - DEBUG - ya.test - _save_outputs: Command (pid 1049998) inblock: 0
2025-10-31 14:31:51,590 - DEBUG - ya.test - _save_outputs: Command (pid 1049998) isrss: 0
2025-10-31 14:31:51,590 - DEBUG - ya.test - _save_outputs: Command (pid 1049998) ixrss: 0
2025-10-31 14:31:51,591 - DEBUG - ya.test - _save_outputs: Command (pid 1049998) majflt: 0
2025-10-31 14:31:51,591 - DEBUG - ya.test - _save_outputs: Command (pid 1049998) maxrss: 483148
2025-10-31 14:31:51,591 - DEBUG - ya.test - _save_outputs: Command (pid 1049998) minflt: 45360
2025-10-31 14:31:51,592 - DEBUG - ya.test - _save_outputs: Command (pid 1049998) msgrcv: 0
2025-10-31 14:31:51,592 - DEBUG - ya.test - _save_outputs: Command (pid 1049998) msgsnd: 0
2025-10-31 14:31:51,592 - DEBUG - ya.test - _save_outputs: Command (pid 1049998) nivcsw: 226
2025-10-31 14:31:51,593 - DEBUG - ya.test - _save_outputs: Command (pid 1049998) nsignals: 0
2025-10-31 14:31:51,593 - DEBUG - ya.test - _save_outputs: Command (pid 1049998) nswap: 0
2025-10-31 14:31:51,593 - DEBUG - ya.test - _save_outputs: Command (pid 1049998) nvcsw: 14
2025-10-31 14:31:51,594 - DEBUG - ya.test - _save_outputs: Command (pid 1049998) oublock: 8
2025-10-31 14:31:51,594 - DEBUG - ya.test - _save_outputs: Command (pid 1049998) stime: 0.240421
2025-10-31 14:31:51,594 - DEBUG - ya.test - _save_outputs: Command (pid 1049998) utime: 0.560991
2025-10-31 14:31:51,595 - DEBUG - ya.test - _save_outputs: Command (pid 1049998) wtime: 1.345
2025-10-31 14:31:51,595 - DEBUG - ya.test - _save_outputs: Command (pid 1049998) output:
Git info:
    Commit: 81e21063d590ae7636d4475c58381f90e065d70f
    Branch: 
    Author: xyliganSereja <matva0509@gmail.com>
    Summary: Merge 4453e1bb1feb0e82a9049e95374936e29fc264d7 into d79725158e2f111172387151aa3fd9735997d399

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-uk32wjuvr4
    Host information: 
        Linux ghrun-uk32wjuvr4 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/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/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-10-31 14:31:51,595 - DEBUG - ya.test - _save_outputs: Command (pid 1049998) errors:

2025-10-31 14:31:51,596 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 81e21063d590ae7636d4475c58381f90e065d70f
    Branch: 
    Author: xyliganSereja <matva0509@gmail.com>
    Summary: Merge 4453e1bb1feb0e82a9049e95374936e29fc264d7 into d79725158e2f111172387151aa3fd9735997d399
2025-10-31 14:31:57,454 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/zwqj/0014b9/ydb/apps/ydbd/ydbd
2025-10-31 14:31:57,454 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/zwqj/0014b9/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:10080', '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: 26579\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-10-31 14:31:57,456 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-10-31 14:31:57,457 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-10-31 14:31:57,457 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/zwqj/0014b9/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:10080', '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: 26579\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-10-31 14:31:57,473 - DEBUG - ya.test - execute: Command pid: 1051176
2025-10-31 14:31:58,775 - DEBUG - ya.test - _save_outputs: Command (pid 1051176) rc: 0
2025-10-31 14:31:58,775 - DEBUG - ya.test - _save_outputs: Command (pid 1051176) elapsed time (sec): 1.3006198406219482
2025-10-31 14:31:58,776 - DEBUG - ya.test - _save_outputs: Command (pid 1051176) idrss: 0
2025-10-31 14:31:58,776 - DEBUG - ya.test - _save_outputs: Command (pid 1051176) inblock: 0
2025-10-31 14:31:58,776 - DEBUG - ya.test - _save_outputs: Command (pid 1051176) isrss: 0
2025-10-31 14:31:58,777 - DEBUG - ya.test - _save_outputs: Command (pid 1051176) ixrss: 0
2025-10-31 14:31:58,777 - DEBUG - ya.test - _save_outputs: Command (pid 1051176) majflt: 0
2025-10-31 14:31:58,777 - DEBUG - ya.test - _save_outputs: Command (pid 1051176) maxrss: 595904
2025-10-31 14:31:58,778 - DEBUG - ya.test - _save_outputs: Command (pid 1051176) minflt: 51682
2025-10-31 14:31:58,778 - DEBUG - ya.test - _save_outputs: Command (pid 1051176) msgrcv: 0
2025-10-31 14:31:58,778 - DEBUG - ya.test - _save_outputs: Command (pid 1051176) msgsnd: 0
2025-10-31 14:31:58,778 - DEBUG - ya.test - _save_outputs: Command (pid 1051176) nivcsw: 259
2025-10-31 14:31:58,779 - DEBUG - ya.test - _save_outputs: Command (pid 1051176) nsignals: 0
2025-10-31 14:31:58,779 - DEBUG - ya.test - _save_outputs: Command (pid 1051176) nswap: 0
2025-10-31 14:31:58,779 - DEBUG - ya.test - _save_outputs: Command (pid 1051176) nvcsw: 651
2025-10-31 14:31:58,780 - DEBUG - ya.test - _save_outputs: Command (pid 1051176) oublock: 8
2025-10-31 14:31:58,780 - DEBUG - ya.test - _save_outputs: Command (pid 1051176) stime: 0.264949
2025-10-31 14:31:58,781 - DEBUG - ya.test - _save_outputs: Command (pid 1051176) utime: 0.601656
2025-10-31 14:31:58,781 - DEBUG - ya.test - _save_outputs: Command (pid 1051176) wtime: 1.317
2025-10-31 14:31:58,781 - DEBUG - ya.test - _save_outputs: Command (pid 1051176) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-10-31 14:31:58,782 - DEBUG - ya.test - _save_outputs: Command (pid 1051176) errors:

2025-10-31 14:31:58,783 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/zwqj/0014b9/ydb/apps/ydbd/ydbd
2025-10-31 14:31:58,784 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/zwqj/0014b9/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:10080', '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-10-31 14:31:58,785 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-10-31 14:31:58,786 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-10-31 14:31:58,787 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/zwqj/0014b9/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:10080', '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-10-31 14:31:58,793 - DEBUG - ya.test - execute: Command pid: 1051631
2025-10-31 14:32:00,125 - DEBUG - ya.test - _save_outputs: Command (pid 1051631) rc: 0
2025-10-31 14:32:00,126 - DEBUG - ya.test - _save_outputs: Command (pid 1051631) elapsed time (sec): 1.330928087234497
2025-10-31 14:32:00,126 - DEBUG - ya.test - _save_outputs: Command (pid 1051631) idrss: 0
2025-10-31 14:32:00,126 - DEBUG - ya.test - _save_outputs: Command (pid 1051631) inblock: 0
2025-10-31 14:32:00,127 - DEBUG - ya.test - _save_outputs: Command (pid 1051631) isrss: 0
2025-10-31 14:32:00,127 - DEBUG - ya.test - _save_outputs: Command (pid 1051631) ixrss: 0
2025-10-31 14:32:00,127 - DEBUG - ya.test - _save_outputs: Command (pid 1051631) majflt: 0
2025-10-31 14:32:00,127 - DEBUG - ya.test - _save_outputs: Command (pid 1051631) maxrss: 596220
2025-10-31 14:32:00,128 - DEBUG - ya.test - _save_outputs: Command (pid 1051631) minflt: 51807
2025-10-31 14:32:00,128 - DEBUG - ya.test - _save_outputs: Command (pid 1051631) msgrcv: 0
2025-10-31 14:32:00,129 - DEBUG - ya.test - _save_outputs: Command (pid 1051631) msgsnd: 0
2025-10-31 14:32:00,129 - DEBUG - ya.test - _save_outputs: Command (pid 1051631) nivcsw: 212
2025-10-31 14:32:00,130 - DEBUG - ya.test - _save_outputs: Command (pid 1051631) nsignals: 0
2025-10-31 14:32:00,130 - DEBUG - ya.test - _save_outputs: Command (pid 1051631) nswap: 0
2025-10-31 14:32:00,130 - DEBUG - ya.test - _save_outputs: Command (pid 1051631) nvcsw: 697
2025-10-31 14:32:00,131 - DEBUG - ya.test - _save_outputs: Command (pid 1051631) oublock: 8
2025-10-31 14:32:00,131 - DEBUG - ya.test - _save_outputs: Command (pid 1051631) stime: 0.303374
2025-10-31 14:32:00,131 - DEBUG - ya.test - _save_outputs: Command (pid 1051631) utime: 0.5147039999999999
2025-10-31 14:32:00,132 - DEBUG - ya.test - _save_outputs: Command (pid 1051631) wtime: 1.337
2025-10-31 14:32:00,132 - DEBUG - ya.test - _save_outputs: Command (pid 1051631) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-10-31 14:32:00,132 - DEBUG - ya.test - _save_outputs: Command (pid 1051631) errors:

2025-10-31 14:32:00,133 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-10-31 14:32:00,317 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-10-31 14:32:00,386 - DEBUG - ydb.connection - 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-10-31 14:32:00,401 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 14:32:00,402 - DEBUG - ydb.connection - 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-10-31 14:32:00,469 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-10-31 14:32:00,470 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, e7806043-24d8-4adb-b5c8-326436f84d38, localhost:10080): creating call state
2025-10-31 14:32:00,471 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, e7806043-24d8-4adb-b5c8-326436f84d38, localhost:10080): request = { database: "/Root" }
2025-10-31 14:32:00,480 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, e7806043-24d8-4adb-b5c8-326436f84d38, localhost:10080): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-uk32wjuvr4.auto.internal" port: 10080 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-10-31 14:32:00,481 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-uk32wjuvr4.auto.internal:10080, location 1, ssl: False>]>
2025-10-31 14:32:00,489 - DEBUG - ydb.connection - 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-10-31 14:32:00,522 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:10080
2025-10-31 14:32:00,525 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-10-31 14:32:00,527 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 52a2113f-0135-45dc-a1d1-562be8308023, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:00,527 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 52a2113f-0135-45dc-a1d1-562be8308023, ghrun-uk32wjuvr4.auto.internal:10080): request = {  }
2025-10-31 14:32:00,542 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 52a2113f-0135-45dc-a1d1-562be8308023, ghrun-uk32wjuvr4.auto.internal:10080): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" node_id: 1 }
2025-10-31 14:32:00,543 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, 5f3fed1b-1e26-4719-ae15-d115c5207bb6, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:00,543 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, 5f3fed1b-1e26-4719-ae15-d115c5207bb6, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" }
2025-10-31 14:32:00,557 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, 5f3fed1b-1e26-4719-ae15-d115c5207bb6, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:00,569 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:00,571 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 84315af1-2205-4090-ba62-8ffa70d1d9d3, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:00,572 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 84315af1-2205-4090-ba62-8ffa70d1d9d3, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:00,578 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 84315af1-2205-4090-ba62-8ffa70d1d9d3, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:05,678 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:05,679 - INFO - __tests__.alter_compression - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-10-31 14:32:05,680 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:05,680 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9bba2d22-eb35-40b6-95d5-534478dd510b, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:05,682 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9bba2d22-eb35-40b6-95d5-534478dd510b, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:05,683 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9bba2d22-eb35-40b6-95d5-534478dd510b, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:07,176 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:07,177 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:07,178 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1236a7c5-d974-4230-9673-921f4517b61d, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:07,179 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1236a7c5-d974-4230-9673-921f4517b61d, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:07,197 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1236a7c5-d974-4230-9673-921f4517b61d, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:09,136 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:09,137 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:09,138 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 29e79c76-c150-4c3a-a44e-ce8a499fffd4, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:09,139 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 29e79c76-c150-4c3a-a44e-ce8a499fffd4, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:09,151 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 29e79c76-c150-4c3a-a44e-ce8a499fffd4, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:10,689 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:10,690 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:10,691 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 03002f23-f0ac-42ac-8b4e-23ce39a77f7e, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:10,692 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 03002f23-f0ac-42ac-8b4e-23ce39a77f7e, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:10,698 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 03002f23-f0ac-42ac-8b4e-23ce39a77f7e, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:12,949 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:12,950 - INFO - __tests__.alter_compression - 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-10-31 14:32:12,950 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:12,951 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4fbec409-5090-4560-9b35-8cfd4fde866f, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:12,952 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4fbec409-5090-4560-9b35-8cfd4fde866f, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:12,955 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4fbec409-5090-4560-9b35-8cfd4fde866f, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:14,070 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:14,071 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:14,072 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 37c36e1d-d610-418e-9b9d-43664d1f926e, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:14,073 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 37c36e1d-d610-418e-9b9d-43664d1f926e, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:14,074 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 37c36e1d-d610-418e-9b9d-43664d1f926e, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:14,313 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:14,314 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:14,315 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1752a917-897d-4fda-b64c-8a8883ba0033, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:14,316 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1752a917-897d-4fda-b64c-8a8883ba0033, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:14,318 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1752a917-897d-4fda-b64c-8a8883ba0033, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:14,906 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:14,907 - INFO - __tests__.alter_compression - 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-10-31 14:32:14,908 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:14,909 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2a59a11c-3dfb-479f-bfc6-7e8098274fd9, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:14,910 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2a59a11c-3dfb-479f-bfc6-7e8098274fd9, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:14,911 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2a59a11c-3dfb-479f-bfc6-7e8098274fd9, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:16,265 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:16,266 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:16,266 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7c3b38c4-a9d8-4f4f-b8c1-74c4bf2dfacc, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:16,267 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7c3b38c4-a9d8-4f4f-b8c1-74c4bf2dfacc, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:16,268 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7c3b38c4-a9d8-4f4f-b8c1-74c4bf2dfacc, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:16,623 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:16,624 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:16,624 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1467e9c2-569d-4013-8b65-00ebfbfdf4b5, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:16,625 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1467e9c2-569d-4013-8b65-00ebfbfdf4b5, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:16,627 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1467e9c2-569d-4013-8b65-00ebfbfdf4b5, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:17,325 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:17,326 - INFO - __tests__.alter_compression - 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-10-31 14:32:17,326 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:17,327 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 488486d9-a6e1-4113-966d-de3999b9bb13, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:17,328 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 488486d9-a6e1-4113-966d-de3999b9bb13, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:17,330 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 488486d9-a6e1-4113-966d-de3999b9bb13, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:18,819 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:18,819 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:18,820 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f5a8b4d5-1a8c-4002-b272-59de31bf943d, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:18,821 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f5a8b4d5-1a8c-4002-b272-59de31bf943d, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:18,823 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f5a8b4d5-1a8c-4002-b272-59de31bf943d, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:19,419 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:19,420 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:19,421 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b6fd481c-551f-43cc-8afd-b03094e84e5f, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:19,422 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b6fd481c-551f-43cc-8afd-b03094e84e5f, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:19,426 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b6fd481c-551f-43cc-8afd-b03094e84e5f, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:20,359 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:20,360 - INFO - __tests__.alter_compression - 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-10-31 14:32:20,361 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:20,362 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, edec498c-0e88-4adb-921d-d92a2eda1087, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:20,363 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, edec498c-0e88-4adb-921d-d92a2eda1087, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:20,368 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, edec498c-0e88-4adb-921d-d92a2eda1087, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:21,921 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:21,922 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:21,923 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c9e82d62-6952-4e74-94be-a6d045db233d, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:21,924 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c9e82d62-6952-4e74-94be-a6d045db233d, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:21,927 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c9e82d62-6952-4e74-94be-a6d045db233d, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:22,516 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:22,517 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:22,518 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2421ace8-4efd-4c99-99a3-d0d4059f32e6, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:22,519 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2421ace8-4efd-4c99-99a3-d0d4059f32e6, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:22,547 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2421ace8-4efd-4c99-99a3-d0d4059f32e6, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:23,389 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:23,390 - INFO - __tests__.alter_compression - 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-10-31 14:32:23,391 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:23,391 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2782382f-0015-4ff3-b7ba-79243a52c0f5, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:23,393 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2782382f-0015-4ff3-b7ba-79243a52c0f5, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:23,395 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2782382f-0015-4ff3-b7ba-79243a52c0f5, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:25,016 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:25,017 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:25,018 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, caeaaee5-a65d-4ce0-ae0b-58c1772e1aef, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:25,019 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, caeaaee5-a65d-4ce0-ae0b-58c1772e1aef, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:25,023 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, caeaaee5-a65d-4ce0-ae0b-58c1772e1aef, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:25,445 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:25,446 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:25,447 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 40257e79-d30e-436e-ba26-65d2fc491d04, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:25,448 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 40257e79-d30e-436e-ba26-65d2fc491d04, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:25,449 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 40257e79-d30e-436e-ba26-65d2fc491d04, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:26,389 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:26,390 - INFO - __tests__.alter_compression - 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-10-31 14:32:26,390 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:26,391 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 78e16c6f-218a-4564-b498-bb0651fd3dd9, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:26,392 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 78e16c6f-218a-4564-b498-bb0651fd3dd9, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:26,409 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 78e16c6f-218a-4564-b498-bb0651fd3dd9, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:27,655 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:27,656 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:27,657 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 08864c0e-e2fa-4045-9ebc-01db653a496f, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:27,658 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 08864c0e-e2fa-4045-9ebc-01db653a496f, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:27,659 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 08864c0e-e2fa-4045-9ebc-01db653a496f, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:28,170 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:28,171 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:28,171 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 52dac0f6-4ed5-4cc6-84ba-092bffd108a2, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:28,173 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 52dac0f6-4ed5-4cc6-84ba-092bffd108a2, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:28,174 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 52dac0f6-4ed5-4cc6-84ba-092bffd108a2, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:29,343 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:29,344 - INFO - __tests__.alter_compression - 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-10-31 14:32:29,344 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:29,345 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 02706fa0-127a-49c9-a8de-639221a681ca, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:29,346 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 02706fa0-127a-49c9-a8de-639221a681ca, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:29,348 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 02706fa0-127a-49c9-a8de-639221a681ca, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:30,989 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:30,990 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:30,991 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, dd958a71-74f4-425b-9b38-6c15dffbf7f8, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:30,992 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, dd958a71-74f4-425b-9b38-6c15dffbf7f8, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:30,993 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, dd958a71-74f4-425b-9b38-6c15dffbf7f8, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:31,346 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:31,347 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:31,348 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b9049882-50bd-469b-9191-3e6d587801c3, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:31,364 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b9049882-50bd-469b-9191-3e6d587801c3, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:31,366 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b9049882-50bd-469b-9191-3e6d587801c3, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:32,291 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:32,292 - INFO - __tests__.alter_compression - 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-10-31 14:32:32,292 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:32,293 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 95de774d-0223-4491-8b76-5e80ae96e477, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:32,294 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 95de774d-0223-4491-8b76-5e80ae96e477, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:32,298 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 95de774d-0223-4491-8b76-5e80ae96e477, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:33,669 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:33,670 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:33,671 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2cda4af5-3d4a-47ac-8446-d7908f109391, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:33,672 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2cda4af5-3d4a-47ac-8446-d7908f109391, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:33,674 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2cda4af5-3d4a-47ac-8446-d7908f109391, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:34,085 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:34,086 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:34,087 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2d9dda79-082e-41fb-bff0-81a57d665446, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:34,088 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2d9dda79-082e-41fb-bff0-81a57d665446, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:34,090 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2d9dda79-082e-41fb-bff0-81a57d665446, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:35,007 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:35,008 - INFO - __tests__.alter_compression - 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-10-31 14:32:35,009 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:35,010 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5cf9e370-7a32-43e9-b2a8-1b86cc211886, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:35,011 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5cf9e370-7a32-43e9-b2a8-1b86cc211886, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:35,014 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5cf9e370-7a32-43e9-b2a8-1b86cc211886, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:36,429 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:36,430 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:36,432 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 03b99749-eb1e-4e9d-b0ec-bd69bd65c3b2, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:36,433 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 03b99749-eb1e-4e9d-b0ec-bd69bd65c3b2, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:36,434 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 03b99749-eb1e-4e9d-b0ec-bd69bd65c3b2, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:37,025 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:37,026 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:37,026 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a0be67d1-50e7-4c99-a417-72bd7f1e1056, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:37,027 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a0be67d1-50e7-4c99-a417-72bd7f1e1056, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:37,031 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a0be67d1-50e7-4c99-a417-72bd7f1e1056, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:38,260 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:38,261 - INFO - __tests__.alter_compression - 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-10-31 14:32:38,262 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:38,263 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3d276dd8-885e-4898-b5d5-e2cea7bd1491, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:38,263 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3d276dd8-885e-4898-b5d5-e2cea7bd1491, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:38,273 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3d276dd8-885e-4898-b5d5-e2cea7bd1491, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:39,823 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:39,825 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:39,826 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f736b536-4a0e-4277-908a-430086f6d049, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:39,827 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f736b536-4a0e-4277-908a-430086f6d049, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:39,834 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f736b536-4a0e-4277-908a-430086f6d049, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:40,220 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:40,221 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:40,222 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4aeaf856-b327-4ea9-87aa-b2a51479d262, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:40,223 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4aeaf856-b327-4ea9-87aa-b2a51479d262, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:40,235 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4aeaf856-b327-4ea9-87aa-b2a51479d262, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:40,634 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:40,635 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:40,636 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 121e033f-4245-4b81-a9ab-ce684c27be91, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:40,637 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 121e033f-4245-4b81-a9ab-ce684c27be91, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:40,644 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 121e033f-4245-4b81-a9ab-ce684c27be91, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:48,336 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:58,379 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:32:58,381 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d9e8a06f-30ee-41af-bc69-abff07610c02, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:32:58,382 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d9e8a06f-30ee-41af-bc69-abff07610c02, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:32:58,383 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d9e8a06f-30ee-41af-bc69-abff07610c02, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:33:04,932 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:33:04,980 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-10-31 14:33:04,980 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:33:04,982 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2bad52d5-3bf9-440e-9b46-a4691057d815, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:33:04,982 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2bad52d5-3bf9-440e-9b46-a4691057d815, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:33:04,984 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2bad52d5-3bf9-440e-9b46-a4691057d815, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:33:14,858 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:33:24,897 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:33:24,898 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8f0772f9-bc2e-4fa3-b0a2-731a4d052add, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:33:24,899 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8f0772f9-bc2e-4fa3-b0a2-731a4d052add, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:33:24,903 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8f0772f9-bc2e-4fa3-b0a2-731a4d052add, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:33:26,600 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:33:36,609 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:33:36,610 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3d124d0d-cf60-463e-a573-25d8142e6c49, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:33:36,611 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3d124d0d-cf60-463e-a573-25d8142e6c49, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:33:36,619 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3d124d0d-cf60-463e-a573-25d8142e6c49, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:33:37,579 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:33:47,585 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:33:47,586 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 03879d9d-c1ce-4c10-a47d-db13c8b35531, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:33:47,587 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 03879d9d-c1ce-4c10-a47d-db13c8b35531, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:33:47,590 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 03879d9d-c1ce-4c10-a47d-db13c8b35531, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:33:48,738 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:33:48,743 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8009216)
2025-10-31 14:33:48,744 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:33:48,745 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 174edbdb-e8ff-4531-8011-2c9792f8fe42, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:33:48,746 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 174edbdb-e8ff-4531-8011-2c9792f8fe42, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" 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-10-31 14:33:48,748 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 174edbdb-e8ff-4531-8011-2c9792f8fe42, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:33:49,368 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:33:49,372 - INFO - ya.test - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_8_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 8])
2025-10-31 14:33:49,380 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:33:49,381 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 06e2ad89-0500-4eb3-acb4-d3c519676698, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:33:49,382 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 06e2ad89-0500-4eb3-acb4-d3c519676698, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_8_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 8)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:33:49,385 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 06e2ad89-0500-4eb3-acb4-d3c519676698, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:33:51,257 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 14:33:51,258 - DEBUG - ydb.connection - 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-10-31 14:33:51,286 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-10-31 14:33:51,287 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, b94aad38-1d86-4ad9-ac60-509c63165f68, localhost:10080): creating call state
2025-10-31 14:33:51,287 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, b94aad38-1d86-4ad9-ac60-509c63165f68, localhost:10080): request = { database: "/Root" }
2025-10-31 14:33:53,392 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, b94aad38-1d86-4ad9-ac60-509c63165f68, localhost:10080): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-uk32wjuvr4.auto.internal" port: 10080 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-10-31 14:33:53,393 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-uk32wjuvr4.auto.internal:10080, location 1, ssl: False>]>
2025-10-31 14:33:53,394 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:10080
2025-10-31 14:33:54,444 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:33:54,445 - INFO - __tests__.alter_compression - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_8_compression created
2025-10-31 14:33:54,445 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:33:54,446 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6e00ddce-b4d5-4bf9-8610-a644c592a8e3, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:33:54,447 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6e00ddce-b4d5-4bf9-8610-a644c592a8e3, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_8_compression`" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:33:54,458 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6e00ddce-b4d5-4bf9-8610-a644c592a8e3, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:33:55,855 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:33:55,856 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:33:55,857 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, dc18a5c9-4d66-4ec1-b41a-acbcc6c52745, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:33:55,858 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, dc18a5c9-4d66-4ec1-b41a-acbcc6c52745, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 0;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:33:55,867 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, dc18a5c9-4d66-4ec1-b41a-acbcc6c52745, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:33:59,077 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:33:59,078 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:33:59,079 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3381bddc-6d43-4d67-ab10-9add96ce0223, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:33:59,080 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3381bddc-6d43-4d67-ab10-9add96ce0223, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:33:59,085 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3381bddc-6d43-4d67-ab10-9add96ce0223, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:00,642 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:00,643 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:00,643 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 368956af-4636-4fdd-8d6d-b7e30b679a85, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:00,644 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 368956af-4636-4fdd-8d6d-b7e30b679a85, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:00,646 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 368956af-4636-4fdd-8d6d-b7e30b679a85, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:03,237 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:03,238 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318016, 'BlobCount': 128}}
2025-10-31 14:34:03,238 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:03,239 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c70afd86-0a15-4185-bd2a-a56bee179e78, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:03,240 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c70afd86-0a15-4185-bd2a-a56bee179e78, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 100000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:03,242 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c70afd86-0a15-4185-bd2a-a56bee179e78, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:05,936 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:05,937 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:05,938 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2b8e3c8a-4f2c-41c4-9a97-33f05300cd53, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:05,939 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2b8e3c8a-4f2c-41c4-9a97-33f05300cd53, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:05,941 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2b8e3c8a-4f2c-41c4-9a97-33f05300cd53, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:06,446 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:06,447 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:06,448 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5208cbcf-aee5-4df4-8ec6-a9b48480a753, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:06,449 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5208cbcf-aee5-4df4-8ec6-a9b48480a753, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:06,457 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5208cbcf-aee5-4df4-8ec6-a9b48480a753, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:07,161 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:07,162 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 637312, 'BlobCount': 256}}
2025-10-31 14:34:07,162 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:07,163 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a0090100-1ba0-4594-bc85-028d8ef305da, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:07,164 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a0090100-1ba0-4594-bc85-028d8ef305da, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 200000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:07,168 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a0090100-1ba0-4594-bc85-028d8ef305da, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:09,853 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:09,854 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:09,855 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 32869174-d67e-4604-a5e1-2ce16e64ae2b, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:09,855 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 32869174-d67e-4604-a5e1-2ce16e64ae2b, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:09,858 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 32869174-d67e-4604-a5e1-2ce16e64ae2b, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:10,446 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:10,447 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:10,448 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 389bfced-f271-4910-ac68-00c026c0d56b, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:10,449 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 389bfced-f271-4910-ac68-00c026c0d56b, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:10,453 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 389bfced-f271-4910-ac68-00c026c0d56b, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:11,226 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:11,227 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 956352, 'BlobCount': 384}}
2025-10-31 14:34:11,228 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:11,228 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7e926a22-9c9f-4788-a65c-a69620f237dc, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:11,229 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7e926a22-9c9f-4788-a65c-a69620f237dc, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 300000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:11,231 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7e926a22-9c9f-4788-a65c-a69620f237dc, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:14,009 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:14,010 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:14,011 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 32644242-2cb7-4553-80a2-cc3992d1c65f, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:14,012 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 32644242-2cb7-4553-80a2-cc3992d1c65f, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:14,014 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 32644242-2cb7-4553-80a2-cc3992d1c65f, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:14,571 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:14,572 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:14,573 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1c6623a5-6209-4a61-aab9-e0d246d3f001, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:14,574 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1c6623a5-6209-4a61-aab9-e0d246d3f001, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:14,576 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1c6623a5-6209-4a61-aab9-e0d246d3f001, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:15,515 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:15,516 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1275712, 'BlobCount': 512}}
2025-10-31 14:34:15,516 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:15,517 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 66d281f8-236c-4621-8845-61dcffa2bebf, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:15,519 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 66d281f8-236c-4621-8845-61dcffa2bebf, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 400000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:15,526 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 66d281f8-236c-4621-8845-61dcffa2bebf, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:18,185 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:18,185 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:18,186 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 78aa3af5-eece-4e06-9381-97520c1bac99, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:18,187 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 78aa3af5-eece-4e06-9381-97520c1bac99, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:18,196 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 78aa3af5-eece-4e06-9381-97520c1bac99, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:18,920 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:18,921 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:18,922 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 278d5246-3db1-4cff-bd76-6fa1c54bc676, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:18,929 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 278d5246-3db1-4cff-bd76-6fa1c54bc676, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:18,931 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 278d5246-3db1-4cff-bd76-6fa1c54bc676, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:19,746 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:19,747 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1594672, 'BlobCount': 640}}
2025-10-31 14:34:19,747 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:19,748 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ac041b67-94ff-4f62-8d72-ebd1ed4a2438, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:19,749 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ac041b67-94ff-4f62-8d72-ebd1ed4a2438, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 500000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:19,751 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ac041b67-94ff-4f62-8d72-ebd1ed4a2438, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:22,716 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:22,717 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:22,718 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c14371b5-7cf6-403f-bb48-8354fd13e0c7, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:22,719 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c14371b5-7cf6-403f-bb48-8354fd13e0c7, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:22,727 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c14371b5-7cf6-403f-bb48-8354fd13e0c7, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:23,565 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:23,566 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:23,567 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d2be946d-2ad3-428c-8e0a-8eba5d13a681, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:23,568 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d2be946d-2ad3-428c-8e0a-8eba5d13a681, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:23,571 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d2be946d-2ad3-428c-8e0a-8eba5d13a681, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:24,969 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:24,970 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1913856, 'BlobCount': 768}}
2025-10-31 14:34:24,971 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:24,971 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cafdcef1-7410-4747-b4fe-baf71b3daa32, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:24,972 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cafdcef1-7410-4747-b4fe-baf71b3daa32, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 600000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:24,974 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cafdcef1-7410-4747-b4fe-baf71b3daa32, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:27,616 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:27,617 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:27,618 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d3ad9c1c-6f2a-409b-9a11-53f25f6896eb, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:27,619 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d3ad9c1c-6f2a-409b-9a11-53f25f6896eb, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:27,620 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d3ad9c1c-6f2a-409b-9a11-53f25f6896eb, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:28,638 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:28,639 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:28,640 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0c4fb8fe-2313-40fa-9f98-5f929b9540f1, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:28,641 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0c4fb8fe-2313-40fa-9f98-5f929b9540f1, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:28,658 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0c4fb8fe-2313-40fa-9f98-5f929b9540f1, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:29,766 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:29,767 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2232992, 'BlobCount': 896}}
2025-10-31 14:34:29,768 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:29,769 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8d31d996-109b-4074-8224-0b597ae09f57, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:29,770 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8d31d996-109b-4074-8224-0b597ae09f57, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 700000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:29,778 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8d31d996-109b-4074-8224-0b597ae09f57, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:32,645 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:32,645 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:32,646 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 39ae9e57-1e36-4155-98ac-76bb6cc7deef, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:32,648 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 39ae9e57-1e36-4155-98ac-76bb6cc7deef, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:32,650 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 39ae9e57-1e36-4155-98ac-76bb6cc7deef, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:33,479 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:33,480 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:33,481 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3795f4e7-8109-4e44-9b14-b00418e5de3a, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:33,482 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3795f4e7-8109-4e44-9b14-b00418e5de3a, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:33,490 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3795f4e7-8109-4e44-9b14-b00418e5de3a, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:34,840 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:34,841 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2552480, 'BlobCount': 1024}}
2025-10-31 14:34:34,841 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:34,842 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 050c4ccb-2d49-4375-af2d-18a933dedd60, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:34,843 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 050c4ccb-2d49-4375-af2d-18a933dedd60, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 800000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:34,858 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 050c4ccb-2d49-4375-af2d-18a933dedd60, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:37,658 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:37,659 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:37,660 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 50d734a2-95d6-498c-a8a0-a001cd03ed37, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:37,661 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 50d734a2-95d6-498c-a8a0-a001cd03ed37, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:37,663 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 50d734a2-95d6-498c-a8a0-a001cd03ed37, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:38,294 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:38,295 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:38,296 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4a10c0d7-ec0a-45cd-94b1-f94cf47096b5, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:38,298 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4a10c0d7-ec0a-45cd-94b1-f94cf47096b5, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:38,316 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4a10c0d7-ec0a-45cd-94b1-f94cf47096b5, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:39,169 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:39,170 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2871488, 'BlobCount': 1152}}
2025-10-31 14:34:39,171 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:39,171 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 508b3632-117c-4bb3-a8b1-085afe29dc31, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:39,182 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 508b3632-117c-4bb3-a8b1-085afe29dc31, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 900000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:39,184 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 508b3632-117c-4bb3-a8b1-085afe29dc31, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:42,168 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:42,169 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:42,170 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 33e46702-62b2-4ead-86da-96f67fb100c5, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:42,171 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 33e46702-62b2-4ead-86da-96f67fb100c5, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:42,175 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 33e46702-62b2-4ead-86da-96f67fb100c5, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:42,676 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:42,677 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:42,682 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0973f369-8577-4902-96f6-1dd28a470976, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:42,683 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0973f369-8577-4902-96f6-1dd28a470976, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:42,690 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0973f369-8577-4902-96f6-1dd28a470976, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:44,070 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:44,071 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3190992, 'BlobCount': 1280}}
2025-10-31 14:34:44,072 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:44,073 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0acfac5a-18f6-4664-892e-85ac9aa287bb, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:44,074 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0acfac5a-18f6-4664-892e-85ac9aa287bb, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_8_compression`" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:44,075 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0acfac5a-18f6-4664-892e-85ac9aa287bb, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:46,108 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:46,109 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:46,110 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 800c567b-ca8a-44cf-8690-22602f3323b6, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:46,111 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 800c567b-ca8a-44cf-8690-22602f3323b6, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:46,125 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 800c567b-ca8a-44cf-8690-22602f3323b6, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:46,525 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:46,526 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:46,527 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 99bb96ca-87e1-458d-ac40-c7f8ec506409, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:46,529 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 99bb96ca-87e1-458d-ac40-c7f8ec506409, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:46,530 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 99bb96ca-87e1-458d-ac40-c7f8ec506409, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:47,000 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:47,001 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:34:47,002 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ec7f124d-2210-405d-a9f0-7d4d97552d7e, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:34:47,003 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ec7f124d-2210-405d-a9f0-7d4d97552d7e, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:47,004 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ec7f124d-2210-405d-a9f0-7d4d97552d7e, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:53,199 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:35:03,284 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:35:03,285 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d4306154-b34c-4e77-87af-931aa9a28ea6, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:35:03,286 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d4306154-b34c-4e77-87af-931aa9a28ea6, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:35:03,287 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d4306154-b34c-4e77-87af-931aa9a28ea6, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:35:06,825 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:35:06,850 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_8_compression`, volumes `value` (8000000, 1507976)
2025-10-31 14:35:06,851 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:35:06,851 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2bc3abe7-ee27-4777-8933-d3eb392fa172, ghrun-uk32wjuvr4.auto.internal:10080): creating call state
2025-10-31 14:35:06,853 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2bc3abe7-ee27-4777-8933-d3eb392fa172, ghrun-uk32wjuvr4.auto.internal:10080): request = { session_id: "ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:35:06,854 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2bc3abe7-ee27-4777-8933-d3eb392fa172, ghrun-uk32wjuvr4.auto.internal:10080): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:35:08,001 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YTU3NjU5ZTAtZGI0ZGUyMzAtZTJmNjI5NWUtM2Y0YTU3NWU=
2025-10-31 14:35:09,534 - ERROR - ya.test - logreport: ydb/tests/olap/column_family/compression/alter_compression.py:194: in test_all_supported_compression
    assert table.get_portion_stat_by_tier()['__DEFAULT']['Rows'] == expected_raw // 8
E   assert 1031195 == (8000000 // 8)
2025-10-31 14:35:09,538 - INFO - ya.test - pytest_runtest_teardown: Test teardown
