2025-10-31 14:31:54,301 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-31 14:31:54,301 - INFO - ya.test - pytest_runtest_setup: test_all_supported_compression[zstd_compression-COMPRESSION = "zstd"]
2025-10-31 14:31:54,302 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-31 14:31:54,302 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-31 14:31:54,305 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-10-31 14:31:54,306 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-10-31 14:31:54,307 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/zwqj/0014b4/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-31 14:31:54,325 - DEBUG - ya.test - execute: Command pid: 1050654
2025-10-31 14:31:56,175 - DEBUG - ya.test - _save_outputs: Command (pid 1050654) rc: 0
2025-10-31 14:31:56,176 - DEBUG - ya.test - _save_outputs: Command (pid 1050654) elapsed time (sec): 1.8483424186706543
2025-10-31 14:31:56,176 - DEBUG - ya.test - _save_outputs: Command (pid 1050654) idrss: 0
2025-10-31 14:31:56,176 - DEBUG - ya.test - _save_outputs: Command (pid 1050654) inblock: 0
2025-10-31 14:31:56,177 - DEBUG - ya.test - _save_outputs: Command (pid 1050654) isrss: 0
2025-10-31 14:31:56,177 - DEBUG - ya.test - _save_outputs: Command (pid 1050654) ixrss: 0
2025-10-31 14:31:56,177 - DEBUG - ya.test - _save_outputs: Command (pid 1050654) majflt: 0
2025-10-31 14:31:56,177 - DEBUG - ya.test - _save_outputs: Command (pid 1050654) maxrss: 483648
2025-10-31 14:31:56,178 - DEBUG - ya.test - _save_outputs: Command (pid 1050654) minflt: 45314
2025-10-31 14:31:56,178 - DEBUG - ya.test - _save_outputs: Command (pid 1050654) msgrcv: 0
2025-10-31 14:31:56,178 - DEBUG - ya.test - _save_outputs: Command (pid 1050654) msgsnd: 0
2025-10-31 14:31:56,179 - DEBUG - ya.test - _save_outputs: Command (pid 1050654) nivcsw: 177
2025-10-31 14:31:56,179 - DEBUG - ya.test - _save_outputs: Command (pid 1050654) nsignals: 0
2025-10-31 14:31:56,179 - DEBUG - ya.test - _save_outputs: Command (pid 1050654) nswap: 0
2025-10-31 14:31:56,179 - DEBUG - ya.test - _save_outputs: Command (pid 1050654) nvcsw: 14
2025-10-31 14:31:56,180 - DEBUG - ya.test - _save_outputs: Command (pid 1050654) oublock: 8
2025-10-31 14:31:56,180 - DEBUG - ya.test - _save_outputs: Command (pid 1050654) stime: 0.17717
2025-10-31 14:31:56,180 - DEBUG - ya.test - _save_outputs: Command (pid 1050654) utime: 0.578994
2025-10-31 14:31:56,181 - DEBUG - ya.test - _save_outputs: Command (pid 1050654) wtime: 1.867
2025-10-31 14:31:56,181 - DEBUG - ya.test - _save_outputs: Command (pid 1050654) 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:56,182 - DEBUG - ya.test - _save_outputs: Command (pid 1050654) errors:

2025-10-31 14:31:56,182 - 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:56,312 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/zwqj/0014b4/ydb/apps/ydbd/ydbd
2025-10-31 14:31:56,314 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/25234
2025-10-31 14:31:56,316 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/zwqj/0014b4/r3tmp/kikimr_cluster_k3_a7673
2025-10-31 14:31:56,361 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/zwqj/0014b4/ydb/apps/ydbd/ydbd
2025-10-31 14:31:56,362 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/5829
2025-10-31 14:31:56,363 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/24430
2025-10-31 14:31:56,364 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18452
2025-10-31 14:31:56,364 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18453
2025-10-31 14:31:56,365 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/8164
2025-10-31 14:31:56,366 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/zwqj/0014b4/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/kikimr_configs"
2025-10-31 14:31:56,366 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/zwqj/0014b4/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/0014b4/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/node_1/logfile_76cmube8.log --grpc-port=5829 --mon-port=24430 --ic-port=25234
2025-10-31 14:31:56,367 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:5829/1, disk_size 68719476736
2025-10-31 14:31:56,367 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/zwqj/0014b4/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/kikimr_configs"
2025-10-31 14:31:56,368 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/zwqj/0014b4/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/0014b4/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/node_1/logfile_76cmube8.log --grpc-port=5829 --mon-port=24430 --ic-port=25234
2025-10-31 14:31:56,369 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/zwqj/0014b4/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/zwqj/0014b4/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/zwqj/0014b4/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/node_1/logfile_76cmube8.log', '--grpc-port=5829', '--mon-port=24430', '--ic-port=25234')' in '/home/runner/.ya/build/build_root/zwqj/0014b4/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/node_1' (no wait)
2025-10-31 14:31:56,373 - DEBUG - ya.test - execute: Command pid: 1050921
2025-10-31 14:31:56,374 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:5829/1
2025-10-31 14:31:56,375 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-10-31 14:31:56,376 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-10-31 14:31:56,377 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/zwqj/0014b4/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-31 14:31:56,393 - DEBUG - ya.test - execute: Command pid: 1050924
2025-10-31 14:31:57,440 - DEBUG - ya.test - _save_outputs: Command (pid 1050924) rc: 0
2025-10-31 14:31:57,441 - DEBUG - ya.test - _save_outputs: Command (pid 1050924) elapsed time (sec): 1.0457422733306885
2025-10-31 14:31:57,441 - DEBUG - ya.test - _save_outputs: Command (pid 1050924) idrss: 0
2025-10-31 14:31:57,441 - DEBUG - ya.test - _save_outputs: Command (pid 1050924) inblock: 0
2025-10-31 14:31:57,442 - DEBUG - ya.test - _save_outputs: Command (pid 1050924) isrss: 0
2025-10-31 14:31:57,442 - DEBUG - ya.test - _save_outputs: Command (pid 1050924) ixrss: 0
2025-10-31 14:31:57,442 - DEBUG - ya.test - _save_outputs: Command (pid 1050924) majflt: 0
2025-10-31 14:31:57,442 - DEBUG - ya.test - _save_outputs: Command (pid 1050924) maxrss: 485444
2025-10-31 14:31:57,443 - DEBUG - ya.test - _save_outputs: Command (pid 1050924) minflt: 45317
2025-10-31 14:31:57,443 - DEBUG - ya.test - _save_outputs: Command (pid 1050924) msgrcv: 0
2025-10-31 14:31:57,443 - DEBUG - ya.test - _save_outputs: Command (pid 1050924) msgsnd: 0
2025-10-31 14:31:57,444 - DEBUG - ya.test - _save_outputs: Command (pid 1050924) nivcsw: 192
2025-10-31 14:31:57,444 - DEBUG - ya.test - _save_outputs: Command (pid 1050924) nsignals: 0
2025-10-31 14:31:57,450 - DEBUG - ya.test - _save_outputs: Command (pid 1050924) nswap: 0
2025-10-31 14:31:57,451 - DEBUG - ya.test - _save_outputs: Command (pid 1050924) nvcsw: 14
2025-10-31 14:31:57,451 - DEBUG - ya.test - _save_outputs: Command (pid 1050924) oublock: 8
2025-10-31 14:31:57,451 - DEBUG - ya.test - _save_outputs: Command (pid 1050924) stime: 0.17868399999999998
2025-10-31 14:31:57,452 - DEBUG - ya.test - _save_outputs: Command (pid 1050924) utime: 0.5407259999999999
2025-10-31 14:31:57,452 - DEBUG - ya.test - _save_outputs: Command (pid 1050924) wtime: 1.062
2025-10-31 14:31:57,452 - DEBUG - ya.test - _save_outputs: Command (pid 1050924) 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:57,453 - DEBUG - ya.test - _save_outputs: Command (pid 1050924) errors:

2025-10-31 14:31:57,453 - 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:32:03,113 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/zwqj/0014b4/ydb/apps/ydbd/ydbd
2025-10-31 14:32:03,114 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/zwqj/0014b4/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:5829', '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: 25234\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-10-31 14:32:03,115 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-10-31 14:32:03,116 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-10-31 14:32:03,116 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/zwqj/0014b4/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:5829', '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: 25234\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-10-31 14:32:03,133 - DEBUG - ya.test - execute: Command pid: 1053159
2025-10-31 14:32:04,661 - DEBUG - ya.test - _save_outputs: Command (pid 1053159) rc: 0
2025-10-31 14:32:04,662 - DEBUG - ya.test - _save_outputs: Command (pid 1053159) elapsed time (sec): 1.5269386768341064
2025-10-31 14:32:04,662 - DEBUG - ya.test - _save_outputs: Command (pid 1053159) idrss: 0
2025-10-31 14:32:04,662 - DEBUG - ya.test - _save_outputs: Command (pid 1053159) inblock: 0
2025-10-31 14:32:04,662 - DEBUG - ya.test - _save_outputs: Command (pid 1053159) isrss: 0
2025-10-31 14:32:04,663 - DEBUG - ya.test - _save_outputs: Command (pid 1053159) ixrss: 0
2025-10-31 14:32:04,663 - DEBUG - ya.test - _save_outputs: Command (pid 1053159) majflt: 0
2025-10-31 14:32:04,663 - DEBUG - ya.test - _save_outputs: Command (pid 1053159) maxrss: 586304
2025-10-31 14:32:04,664 - DEBUG - ya.test - _save_outputs: Command (pid 1053159) minflt: 51746
2025-10-31 14:32:04,664 - DEBUG - ya.test - _save_outputs: Command (pid 1053159) msgrcv: 0
2025-10-31 14:32:04,664 - DEBUG - ya.test - _save_outputs: Command (pid 1053159) msgsnd: 0
2025-10-31 14:32:04,665 - DEBUG - ya.test - _save_outputs: Command (pid 1053159) nivcsw: 253
2025-10-31 14:32:04,665 - DEBUG - ya.test - _save_outputs: Command (pid 1053159) nsignals: 0
2025-10-31 14:32:04,665 - DEBUG - ya.test - _save_outputs: Command (pid 1053159) nswap: 0
2025-10-31 14:32:04,666 - DEBUG - ya.test - _save_outputs: Command (pid 1053159) nvcsw: 716
2025-10-31 14:32:04,666 - DEBUG - ya.test - _save_outputs: Command (pid 1053159) oublock: 8
2025-10-31 14:32:04,666 - DEBUG - ya.test - _save_outputs: Command (pid 1053159) stime: 0.27208699999999997
2025-10-31 14:32:04,667 - DEBUG - ya.test - _save_outputs: Command (pid 1053159) utime: 0.6268239999999999
2025-10-31 14:32:04,667 - DEBUG - ya.test - _save_outputs: Command (pid 1053159) wtime: 1.544
2025-10-31 14:32:04,667 - DEBUG - ya.test - _save_outputs: Command (pid 1053159) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-10-31 14:32:04,668 - DEBUG - ya.test - _save_outputs: Command (pid 1053159) errors:

2025-10-31 14:32:04,671 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/zwqj/0014b4/ydb/apps/ydbd/ydbd
2025-10-31 14:32:04,671 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/zwqj/0014b4/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:5829', '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:32:04,673 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-10-31 14:32:04,674 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-10-31 14:32:04,674 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/zwqj/0014b4/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:5829', '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:32:04,685 - DEBUG - ya.test - execute: Command pid: 1053778
2025-10-31 14:32:06,293 - DEBUG - ya.test - _save_outputs: Command (pid 1053778) rc: 0
2025-10-31 14:32:06,294 - DEBUG - ya.test - _save_outputs: Command (pid 1053778) elapsed time (sec): 1.6070353984832764
2025-10-31 14:32:06,294 - DEBUG - ya.test - _save_outputs: Command (pid 1053778) idrss: 0
2025-10-31 14:32:06,294 - DEBUG - ya.test - _save_outputs: Command (pid 1053778) inblock: 0
2025-10-31 14:32:06,295 - DEBUG - ya.test - _save_outputs: Command (pid 1053778) isrss: 0
2025-10-31 14:32:06,295 - DEBUG - ya.test - _save_outputs: Command (pid 1053778) ixrss: 0
2025-10-31 14:32:06,295 - DEBUG - ya.test - _save_outputs: Command (pid 1053778) majflt: 0
2025-10-31 14:32:06,296 - DEBUG - ya.test - _save_outputs: Command (pid 1053778) maxrss: 586304
2025-10-31 14:32:06,296 - DEBUG - ya.test - _save_outputs: Command (pid 1053778) minflt: 51838
2025-10-31 14:32:06,296 - DEBUG - ya.test - _save_outputs: Command (pid 1053778) msgrcv: 0
2025-10-31 14:32:06,305 - DEBUG - ya.test - _save_outputs: Command (pid 1053778) msgsnd: 0
2025-10-31 14:32:06,305 - DEBUG - ya.test - _save_outputs: Command (pid 1053778) nivcsw: 251
2025-10-31 14:32:06,306 - DEBUG - ya.test - _save_outputs: Command (pid 1053778) nsignals: 0
2025-10-31 14:32:06,306 - DEBUG - ya.test - _save_outputs: Command (pid 1053778) nswap: 0
2025-10-31 14:32:06,306 - DEBUG - ya.test - _save_outputs: Command (pid 1053778) nvcsw: 638
2025-10-31 14:32:06,307 - DEBUG - ya.test - _save_outputs: Command (pid 1053778) oublock: 8
2025-10-31 14:32:06,307 - DEBUG - ya.test - _save_outputs: Command (pid 1053778) stime: 0.287416
2025-10-31 14:32:06,307 - DEBUG - ya.test - _save_outputs: Command (pid 1053778) utime: 0.6037239999999999
2025-10-31 14:32:06,308 - DEBUG - ya.test - _save_outputs: Command (pid 1053778) wtime: 1.618
2025-10-31 14:32:06,308 - DEBUG - ya.test - _save_outputs: Command (pid 1053778) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-10-31 14:32:06,308 - DEBUG - ya.test - _save_outputs: Command (pid 1053778) errors:

2025-10-31 14:32:06,317 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-10-31 14:32:06,524 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-10-31 14:32:06,568 - 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:06,585 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 14:32:06,586 - 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:06,644 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-10-31 14:32:06,645 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, a9055199-fe6f-4799-85c2-d04e5d99d6c8, localhost:5829): creating call state
2025-10-31 14:32:06,646 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, a9055199-fe6f-4799-85c2-d04e5d99d6c8, localhost:5829): request = { database: "/Root" }
2025-10-31 14:32:06,659 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, a9055199-fe6f-4799-85c2-d04e5d99d6c8, localhost:5829): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-uk32wjuvr4.auto.internal" port: 5829 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:06,660 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-uk32wjuvr4.auto.internal:5829, location 1, ssl: False>]>
2025-10-31 14:32:06,662 - 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:06,710 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:5829
2025-10-31 14:32:06,713 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-10-31 14:32:06,715 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, bba400e7-1480-480a-bd98-fc28bd3f6b7a, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:06,715 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, bba400e7-1480-480a-bd98-fc28bd3f6b7a, ghrun-uk32wjuvr4.auto.internal:5829): request = {  }
2025-10-31 14:32:06,731 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, bba400e7-1480-480a-bd98-fc28bd3f6b7a, ghrun-uk32wjuvr4.auto.internal:5829): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" node_id: 1 }
2025-10-31 14:32:06,732 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, 65cffd47-f688-4805-abf7-72f5726561cb, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:06,733 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, 65cffd47-f688-4805-abf7-72f5726561cb, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" }
2025-10-31 14:32:06,746 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, 65cffd47-f688-4805-abf7-72f5726561cb, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:06,769 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:06,771 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 801093bd-5556-4302-b8fd-cf5dbe4d745b, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:06,772 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 801093bd-5556-4302-b8fd-cf5dbe4d745b, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:06,774 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 801093bd-5556-4302-b8fd-cf5dbe4d745b, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:12,028 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:12,029 - INFO - __tests__.alter_compression - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-10-31 14:32:12,030 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:12,031 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b1a82cd8-c60b-4473-a3a1-a78e5e1b9370, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:12,032 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b1a82cd8-c60b-4473-a3a1-a78e5e1b9370, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:12,041 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b1a82cd8-c60b-4473-a3a1-a78e5e1b9370, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:13,423 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:13,424 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:13,425 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a7aade90-8ab5-4204-9f66-4cb339474c71, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:13,426 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a7aade90-8ab5-4204-9f66-4cb339474c71, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:13,428 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a7aade90-8ab5-4204-9f66-4cb339474c71, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:15,229 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:15,230 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:15,231 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 69047b8e-ee83-4404-b497-1408e9f89b74, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:15,233 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 69047b8e-ee83-4404-b497-1408e9f89b74, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:15,235 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 69047b8e-ee83-4404-b497-1408e9f89b74, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:16,399 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:16,399 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:16,400 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d4248c9a-0870-4c3b-b9b7-efa99b8240ab, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:16,401 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d4248c9a-0870-4c3b-b9b7-efa99b8240ab, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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,402 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d4248c9a-0870-4c3b-b9b7-efa99b8240ab, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:18,966 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:18,967 - 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:18,968 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:18,969 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4ae48855-b828-4e09-8a57-e2dad8811eb8, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:18,970 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4ae48855-b828-4e09-8a57-e2dad8811eb8, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:18,972 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4ae48855-b828-4e09-8a57-e2dad8811eb8, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:20,487 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:20,488 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:20,489 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 195ac21a-4c1e-44b7-ac7d-be4a068d853a, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:20,490 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 195ac21a-4c1e-44b7-ac7d-be4a068d853a, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:20,491 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 195ac21a-4c1e-44b7-ac7d-be4a068d853a, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:21,166 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:21,166 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:21,167 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ad0499a0-0827-4cc6-ad5c-9801d25e6cc5, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:21,168 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ad0499a0-0827-4cc6-ad5c-9801d25e6cc5, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:21,170 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ad0499a0-0827-4cc6-ad5c-9801d25e6cc5, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:22,009 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:22,010 - 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:22,010 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:22,011 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 612d49fa-3c4c-4f32-bf3a-fbadb12d2065, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:22,012 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 612d49fa-3c4c-4f32-bf3a-fbadb12d2065, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:22,019 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 612d49fa-3c4c-4f32-bf3a-fbadb12d2065, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:23,570 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:23,571 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:23,572 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 00809e8d-e709-4aa1-8ca6-b22f1163ced5, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:23,573 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 00809e8d-e709-4aa1-8ca6-b22f1163ced5, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:23,575 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 00809e8d-e709-4aa1-8ca6-b22f1163ced5, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:23,877 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:23,878 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:23,879 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1ac3c39c-1960-4053-84e8-43600aee2117, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:23,880 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1ac3c39c-1960-4053-84e8-43600aee2117, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:23,883 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1ac3c39c-1960-4053-84e8-43600aee2117, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:24,590 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:24,591 - 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:24,591 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:24,592 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2e270d13-04c4-415a-af3c-c274f2d72168, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:24,596 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2e270d13-04c4-415a-af3c-c274f2d72168, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:24,597 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2e270d13-04c4-415a-af3c-c274f2d72168, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:25,937 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:25,938 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:25,939 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8a0d057b-d018-41fe-a2bc-fb8c6f800c6b, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:25,940 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8a0d057b-d018-41fe-a2bc-fb8c6f800c6b, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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,941 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8a0d057b-d018-41fe-a2bc-fb8c6f800c6b, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:26,386 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:26,387 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:26,388 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, bd2e8d68-81b5-40cc-9414-9dc8140f134f, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:26,389 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, bd2e8d68-81b5-40cc-9414-9dc8140f134f, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:26,393 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, bd2e8d68-81b5-40cc-9414-9dc8140f134f, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:27,106 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:27,106 - 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:27,107 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:27,108 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 94a1018c-0579-4122-9a3e-ebd048bda269, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:27,109 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 94a1018c-0579-4122-9a3e-ebd048bda269, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:27,110 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 94a1018c-0579-4122-9a3e-ebd048bda269, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:28,589 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:28,590 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:28,591 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f8badfe7-266f-4ec7-9afb-b566c77f04d7, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:28,592 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f8badfe7-266f-4ec7-9afb-b566c77f04d7, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:28,593 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f8badfe7-266f-4ec7-9afb-b566c77f04d7, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:28,934 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:28,935 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:28,935 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cde6c3c3-042e-4d83-9430-bb59049a170c, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:28,936 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cde6c3c3-042e-4d83-9430-bb59049a170c, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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,937 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cde6c3c3-042e-4d83-9430-bb59049a170c, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:29,624 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:29,625 - 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:29,626 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:29,627 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7e31332d-45fa-4cf8-bdcb-1e2129825c8d, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:29,627 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7e31332d-45fa-4cf8-bdcb-1e2129825c8d, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:29,630 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7e31332d-45fa-4cf8-bdcb-1e2129825c8d, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:31,026 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:31,027 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:31,028 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0c47320c-212e-4454-ab4a-5756a37f2304, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:31,029 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0c47320c-212e-4454-ab4a-5756a37f2304, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:31,032 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0c47320c-212e-4454-ab4a-5756a37f2304, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:31,487 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:31,488 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:31,489 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ceeb7ed9-3687-4b34-88e3-d25bbe1e01e4, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:31,490 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ceeb7ed9-3687-4b34-88e3-d25bbe1e01e4, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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,493 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ceeb7ed9-3687-4b34-88e3-d25bbe1e01e4, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:32,562 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:32,563 - 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:32,563 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:32,564 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e21f987d-2d4e-4c3f-9c70-ff1eae3a630c, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:32,565 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e21f987d-2d4e-4c3f-9c70-ff1eae3a630c, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:32,567 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e21f987d-2d4e-4c3f-9c70-ff1eae3a630c, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:34,183 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:34,183 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:34,184 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9901a107-5c56-4f50-b6e2-52e3b062e3ae, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:34,185 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9901a107-5c56-4f50-b6e2-52e3b062e3ae, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:34,191 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9901a107-5c56-4f50-b6e2-52e3b062e3ae, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:34,774 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:34,775 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:34,776 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 822620c3-0c01-4518-920e-3b71ed251219, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:34,777 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 822620c3-0c01-4518-920e-3b71ed251219, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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,779 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 822620c3-0c01-4518-920e-3b71ed251219, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:35,699 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:35,700 - 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:35,700 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:35,701 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 87f86bac-3679-497d-a5df-9f3484aed0c8, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:35,702 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 87f86bac-3679-497d-a5df-9f3484aed0c8, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:35,705 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 87f86bac-3679-497d-a5df-9f3484aed0c8, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:37,261 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:37,262 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:37,262 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 15766ad0-cb04-406a-a54d-8bde4a794009, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:37,263 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 15766ad0-cb04-406a-a54d-8bde4a794009, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:37,265 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 15766ad0-cb04-406a-a54d-8bde4a794009, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:37,789 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:37,790 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:37,791 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 42da04f7-c824-46a0-84de-77ca336a5c0f, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:37,792 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 42da04f7-c824-46a0-84de-77ca336a5c0f, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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,794 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 42da04f7-c824-46a0-84de-77ca336a5c0f, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:39,053 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:39,054 - 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:39,054 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:39,055 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9f467845-4c8a-4dcf-b259-a8c4eb982cbf, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:39,056 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9f467845-4c8a-4dcf-b259-a8c4eb982cbf, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:39,059 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9f467845-4c8a-4dcf-b259-a8c4eb982cbf, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:40,526 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:40,527 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:40,528 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 44cabd6f-e0b2-4fc3-be71-c7fd80180d6c, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:40,529 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 44cabd6f-e0b2-4fc3-be71-c7fd80180d6c, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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,531 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 44cabd6f-e0b2-4fc3-be71-c7fd80180d6c, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:40,921 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:40,922 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:40,923 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 30f63afb-3bfd-4ba7-8765-a6993b299df4, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:40,926 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 30f63afb-3bfd-4ba7-8765-a6993b299df4, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:40,928 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 30f63afb-3bfd-4ba7-8765-a6993b299df4, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:42,467 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:42,468 - 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:42,468 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:42,469 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c65df143-1c08-46bc-98e9-950eb5bf30ec, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:42,470 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c65df143-1c08-46bc-98e9-950eb5bf30ec, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:42,472 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c65df143-1c08-46bc-98e9-950eb5bf30ec, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:43,774 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:43,775 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:43,776 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e34bf8f3-7b64-4bef-8613-ef19c99a8479, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:43,777 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e34bf8f3-7b64-4bef-8613-ef19c99a8479, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:43,781 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e34bf8f3-7b64-4bef-8613-ef19c99a8479, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:44,409 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:44,410 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:44,411 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d64a4721-aaa5-467b-a31c-af8d318610ac, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:44,412 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d64a4721-aaa5-467b-a31c-af8d318610ac, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:44,414 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d64a4721-aaa5-467b-a31c-af8d318610ac, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:45,969 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:45,970 - 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:45,970 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:45,971 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, af785a84-1f04-44a4-9f11-b656f133b9ba, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:45,972 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, af785a84-1f04-44a4-9f11-b656f133b9ba, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:45,974 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, af785a84-1f04-44a4-9f11-b656f133b9ba, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:47,813 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:47,814 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:47,815 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2378fc5d-bd5d-4462-a4df-b07e8b1be208, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:47,815 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2378fc5d-bd5d-4462-a4df-b07e8b1be208, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:47,818 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2378fc5d-bd5d-4462-a4df-b07e8b1be208, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:48,446 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:48,447 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:48,448 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, cca3a1ec-d3c3-431d-9855-18a234486cba, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:48,449 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, cca3a1ec-d3c3-431d-9855-18a234486cba, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:48,450 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, cca3a1ec-d3c3-431d-9855-18a234486cba, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:48,889 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:48,890 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:32:48,891 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d7eba773-99c8-4bb1-a0a0-d6bb9c6a2926, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:32:48,891 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d7eba773-99c8-4bb1-a0a0-d6bb9c6a2926, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:48,893 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d7eba773-99c8-4bb1-a0a0-d6bb9c6a2926, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:32:55,634 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:33:05,748 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:33:05,749 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 36c727b1-34f7-4e45-98e5-aa9f34a1ed4f, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:33:05,750 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 36c727b1-34f7-4e45-98e5-aa9f34a1ed4f, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:05,752 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 36c727b1-34f7-4e45-98e5-aa9f34a1ed4f, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:33:13,805 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:33:13,853 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-10-31 14:33:13,854 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:33:13,863 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 114c4e1a-0a6e-4eda-94fb-5d8e73872926, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:33:13,864 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 114c4e1a-0a6e-4eda-94fb-5d8e73872926, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:13,866 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 114c4e1a-0a6e-4eda-94fb-5d8e73872926, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:33:18,649 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:33:28,721 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:33:28,722 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f7cbdc67-6979-4c4a-bcf3-67c80cd79185, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:33:28,724 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f7cbdc67-6979-4c4a-bcf3-67c80cd79185, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:28,729 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f7cbdc67-6979-4c4a-bcf3-67c80cd79185, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:33:30,283 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:33:40,289 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:33:40,290 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 49bf7fc3-c278-416e-843b-14f09311c4f7, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:33:40,291 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 49bf7fc3-c278-416e-843b-14f09311c4f7, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:40,295 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 49bf7fc3-c278-416e-843b-14f09311c4f7, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:33:41,565 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:33:51,571 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:33:51,572 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ddd2e85d-9718-4620-a52d-f38745ad9864, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:33:51,573 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ddd2e85d-9718-4620-a52d-f38745ad9864, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:51,574 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ddd2e85d-9718-4620-a52d-f38745ad9864, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:33:53,032 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:33:53,036 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8009216)
2025-10-31 14:33:53,047 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:33:53,049 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c23d78ed-2229-4043-a87d-8406061942b2, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:33:53,050 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c23d78ed-2229-4043-a87d-8406061942b2, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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:53,057 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c23d78ed-2229-4043-a87d-8406061942b2, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:33:53,622 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:33:53,626 - INFO - ya.test - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_compression-COMPRESSION = "zstd"])
2025-10-31 14:33:53,637 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:33:53,638 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4b49aaff-b03a-435b-8017-b2af33b05ef9, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:33:53,639 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4b49aaff-b03a-435b-8017-b2af33b05ef9, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\")\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:33:53,648 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4b49aaff-b03a-435b-8017-b2af33b05ef9, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:33:58,714 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:33:58,715 - INFO - __tests__.alter_compression - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_compression created
2025-10-31 14:33:58,715 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:33:58,716 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f66afb4f-272e-45eb-9511-cf38e9cdd305, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:33:58,718 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f66afb4f-272e-45eb-9511-cf38e9cdd305, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_compression`" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:33:58,719 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f66afb4f-272e-45eb-9511-cf38e9cdd305, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:33:59,927 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:33:59,927 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:33:59,928 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6efce371-17fe-4dc2-8ac4-ccbe34164f2a, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:33:59,931 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6efce371-17fe-4dc2-8ac4-ccbe34164f2a, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:33:59,933 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6efce371-17fe-4dc2-8ac4-ccbe34164f2a, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:01,548 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:01,549 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:01,550 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 80ed780b-7835-4e22-896a-d11b8675b749, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:01,551 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 80ed780b-7835-4e22-896a-d11b8675b749, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:01,570 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 80ed780b-7835-4e22-896a-d11b8675b749, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:02,943 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 14:34:02,944 - 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:34:02,968 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-10-31 14:34:02,973 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 741f2ff2-d1b3-44db-8a7d-20fb3a611286, localhost:5829): creating call state
2025-10-31 14:34:02,974 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 741f2ff2-d1b3-44db-8a7d-20fb3a611286, localhost:5829): request = { database: "/Root" }
2025-10-31 14:34:02,986 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 741f2ff2-d1b3-44db-8a7d-20fb3a611286, localhost:5829): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-uk32wjuvr4.auto.internal" port: 5829 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:34:02,993 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-uk32wjuvr4.auto.internal:5829, location 1, ssl: False>]>
2025-10-31 14:34:02,993 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:5829
2025-10-31 14:34:03,026 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:03,027 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:03,028 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c4daab61-66de-48b1-9b1b-9bcaaf1b2fef, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:03,029 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c4daab61-66de-48b1-9b1b-9bcaaf1b2fef, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_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:03,036 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c4daab61-66de-48b1-9b1b-9bcaaf1b2fef, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:04,988 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:04,989 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318880, 'BlobCount': 128}}
2025-10-31 14:34:04,990 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:04,991 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ba1298d2-96d8-4004-816d-ff61622a2a30, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:04,992 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ba1298d2-96d8-4004-816d-ff61622a2a30, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:04,996 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ba1298d2-96d8-4004-816d-ff61622a2a30, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:06,816 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:06,817 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:06,818 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 21e79cd4-08a7-4851-be82-71064e914647, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:06,819 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 21e79cd4-08a7-4851-be82-71064e914647, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:06,820 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 21e79cd4-08a7-4851-be82-71064e914647, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:07,408 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:07,409 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:07,410 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0246b2f0-5784-481c-9846-ecda299f2966, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:07,411 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0246b2f0-5784-481c-9846-ecda299f2966, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_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:07,413 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0246b2f0-5784-481c-9846-ecda299f2966, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:08,318 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:08,319 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 638384, 'BlobCount': 256}}
2025-10-31 14:34:08,319 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:08,320 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4270bf27-084c-443f-bb8c-6ed205bf37e9, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:08,330 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4270bf27-084c-443f-bb8c-6ed205bf37e9, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:08,332 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4270bf27-084c-443f-bb8c-6ed205bf37e9, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:09,686 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:09,687 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:09,688 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 55a24002-a344-43a4-b9c7-299ff9dc0329, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:09,689 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 55a24002-a344-43a4-b9c7-299ff9dc0329, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:09,705 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 55a24002-a344-43a4-b9c7-299ff9dc0329, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:10,210 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:10,211 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:10,211 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6860d7ab-eba8-4d43-a154-6e86a417cd61, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:10,212 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6860d7ab-eba8-4d43-a154-6e86a417cd61, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_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,214 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6860d7ab-eba8-4d43-a154-6e86a417cd61, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:10,967 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:10,968 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 957552, 'BlobCount': 384}}
2025-10-31 14:34:10,968 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:10,969 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a587324f-0f3a-4275-a0ef-35a936cee215, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:10,970 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a587324f-0f3a-4275-a0ef-35a936cee215, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:10,994 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a587324f-0f3a-4275-a0ef-35a936cee215, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:12,714 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:12,714 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:12,715 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e26eac94-7060-4be4-840f-4004c0add845, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:12,716 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e26eac94-7060-4be4-840f-4004c0add845, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:12,722 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e26eac94-7060-4be4-840f-4004c0add845, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:13,135 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:13,136 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:13,137 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7bee983c-7155-4949-b3e5-f86ffc336642, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:13,138 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7bee983c-7155-4949-b3e5-f86ffc336642, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_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:13,156 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7bee983c-7155-4949-b3e5-f86ffc336642, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:13,821 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:13,821 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1277056, 'BlobCount': 512}}
2025-10-31 14:34:13,822 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:13,823 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 49c5aad3-6184-4558-a5f4-4d695d0bfe96, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:13,824 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 49c5aad3-6184-4558-a5f4-4d695d0bfe96, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:13,826 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 49c5aad3-6184-4558-a5f4-4d695d0bfe96, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:15,499 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:15,500 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:15,501 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 845b1e51-826e-465e-acc2-49caf2a6d1a0, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:15,502 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 845b1e51-826e-465e-acc2-49caf2a6d1a0, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:15,506 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 845b1e51-826e-465e-acc2-49caf2a6d1a0, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:16,154 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:16,155 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:16,156 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2c782008-ba04-4e3e-b648-54f851aa94cb, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:16,157 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2c782008-ba04-4e3e-b648-54f851aa94cb, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_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:16,160 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2c782008-ba04-4e3e-b648-54f851aa94cb, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:17,111 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:17,112 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1596256, 'BlobCount': 640}}
2025-10-31 14:34:17,112 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:17,113 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0cb977c7-26c4-4ffd-b59a-1a2c46f06600, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:17,114 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0cb977c7-26c4-4ffd-b59a-1a2c46f06600, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:17,122 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0cb977c7-26c4-4ffd-b59a-1a2c46f06600, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:19,010 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:19,011 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:19,012 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f76d5636-a590-4719-81e8-a007ad16f553, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:19,013 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f76d5636-a590-4719-81e8-a007ad16f553, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:19,021 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f76d5636-a590-4719-81e8-a007ad16f553, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:19,707 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:19,708 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:19,709 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fe49d043-d1fc-4e7d-8389-a6b80f15568f, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:19,710 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fe49d043-d1fc-4e7d-8389-a6b80f15568f, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_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:19,711 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fe49d043-d1fc-4e7d-8389-a6b80f15568f, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:21,001 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:21,002 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1915600, 'BlobCount': 768}}
2025-10-31 14:34:21,002 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:21,003 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fd3c9d52-3d1b-42ca-b7e3-085264028748, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:21,004 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fd3c9d52-3d1b-42ca-b7e3-085264028748, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:21,010 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fd3c9d52-3d1b-42ca-b7e3-085264028748, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:23,136 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:23,137 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:23,138 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d019935a-e420-4cbb-b53d-65a74a253296, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:23,138 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d019935a-e420-4cbb-b53d-65a74a253296, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:23,139 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d019935a-e420-4cbb-b53d-65a74a253296, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:23,751 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:23,752 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:23,752 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f99284dd-e2d1-4962-b668-4dfd09150e3c, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:23,753 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f99284dd-e2d1-4962-b668-4dfd09150e3c, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_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,759 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f99284dd-e2d1-4962-b668-4dfd09150e3c, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:24,999 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:25,000 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2234896, 'BlobCount': 896}}
2025-10-31 14:34:25,000 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:25,001 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e4659058-a92e-425e-8a7f-89c42e669d0b, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:25,002 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e4659058-a92e-425e-8a7f-89c42e669d0b, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:25,017 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e4659058-a92e-425e-8a7f-89c42e669d0b, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:26,433 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:26,434 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:26,435 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6ff7f25e-48a9-45f5-820e-2e2e26e0bd03, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:26,436 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6ff7f25e-48a9-45f5-820e-2e2e26e0bd03, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:26,438 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6ff7f25e-48a9-45f5-820e-2e2e26e0bd03, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:26,965 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:26,966 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:26,967 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 28639d98-4508-4b3c-a851-c78e1c9250ab, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:26,968 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 28639d98-4508-4b3c-a851-c78e1c9250ab, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_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:26,970 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 28639d98-4508-4b3c-a851-c78e1c9250ab, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:28,356 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:28,357 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2554464, 'BlobCount': 1024}}
2025-10-31 14:34:28,358 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:28,359 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0c866dfc-b81a-45c3-9008-5c4539bfee81, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:28,360 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0c866dfc-b81a-45c3-9008-5c4539bfee81, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:28,372 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0c866dfc-b81a-45c3-9008-5c4539bfee81, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:30,304 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:30,305 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:30,305 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c6349d41-2b7c-410b-90c7-423920fe64d1, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:30,306 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c6349d41-2b7c-410b-90c7-423920fe64d1, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:30,309 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c6349d41-2b7c-410b-90c7-423920fe64d1, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:31,058 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:31,059 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:31,060 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6f926417-9dde-480d-8eef-33765595de6b, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:31,061 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6f926417-9dde-480d-8eef-33765595de6b, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_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:31,065 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6f926417-9dde-480d-8eef-33765595de6b, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:32,490 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:32,490 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2873568, 'BlobCount': 1152}}
2025-10-31 14:34:32,491 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:32,492 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b071dd5e-0e54-4a00-b97d-8989852054db, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:32,493 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b071dd5e-0e54-4a00-b97d-8989852054db, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:32,496 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b071dd5e-0e54-4a00-b97d-8989852054db, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:34,613 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:34,614 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:34,615 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ef37da18-3b55-4937-99f0-48bdaf6ed4ec, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:34,616 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ef37da18-3b55-4937-99f0-48bdaf6ed4ec, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:34,617 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ef37da18-3b55-4937-99f0-48bdaf6ed4ec, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:35,214 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:35,215 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:35,216 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a6abb6cb-24cf-4cbb-87cb-6cfaaf2e5703, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:35,217 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a6abb6cb-24cf-4cbb-87cb-6cfaaf2e5703, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_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:35,218 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a6abb6cb-24cf-4cbb-87cb-6cfaaf2e5703, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:36,097 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:36,098 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3193216, 'BlobCount': 1280}}
2025-10-31 14:34:36,098 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:36,099 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 623d155d-d6fe-4738-9bdd-760d1db393e8, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:36,100 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 623d155d-d6fe-4738-9bdd-760d1db393e8, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_compression`" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:36,102 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 623d155d-d6fe-4738-9bdd-760d1db393e8, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:37,901 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:37,902 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:37,902 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1b66287b-970c-416a-964f-128c21188e38, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:37,903 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1b66287b-970c-416a-964f-128c21188e38, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:37,914 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1b66287b-970c-416a-964f-128c21188e38, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:38,667 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:38,667 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:38,668 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 64ba3ece-eca4-4184-9ce2-d4eaeacc2a69, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:38,669 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 64ba3ece-eca4-4184-9ce2-d4eaeacc2a69, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:38,671 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 64ba3ece-eca4-4184-9ce2-d4eaeacc2a69, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:39,140 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:39,140 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:39,141 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3f05a7cd-5582-4d09-83b7-36575f063f83, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:39,142 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3f05a7cd-5582-4d09-83b7-36575f063f83, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:39,144 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3f05a7cd-5582-4d09-83b7-36575f063f83, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:34:46,134 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:56,173 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:34:56,174 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 05c39c1f-718d-4a20-9a67-eae6b4cc3da9, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:34:56,175 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 05c39c1f-718d-4a20-9a67-eae6b4cc3da9, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:34:56,177 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 05c39c1f-718d-4a20-9a67-eae6b4cc3da9, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:35:01,811 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:35:11,865 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:35:11,866 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c6cea171-9004-4a6c-b38b-d0d420afdfe3, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:35:11,867 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c6cea171-9004-4a6c-b38b-d0d420afdfe3, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:35:11,870 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c6cea171-9004-4a6c-b38b-d0d420afdfe3, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:35:13,948 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:35:23,964 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:35:23,965 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ba536f4c-9694-4d42-8080-d316889cad9c, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:35:23,966 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ba536f4c-9694-4d42-8080-d316889cad9c, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:35:23,968 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ba536f4c-9694-4d42-8080-d316889cad9c, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:35:25,182 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:35:25,188 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_compression`, volumes `value` (8000000, 1465272)
2025-10-31 14:35:25,190 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:35:25,191 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 99cd3bb1-3f22-404e-a003-f3644897d625, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:35:25,192 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 99cd3bb1-3f22-404e-a003-f3644897d625, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:35:25,194 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 99cd3bb1-3f22-404e-a003-f3644897d625, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:35:25,942 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:35:25,943 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:35:25,944 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 952421d3-e598-4639-a5c4-09f89f2618e1, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:35:25,945 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 952421d3-e598-4639-a5c4-09f89f2618e1, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:35:25,951 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 952421d3-e598-4639-a5c4-09f89f2618e1, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:35:27,521 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:35:37,529 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:35:37,530 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0da61966-3964-4144-81c3-d43a9c01d1ad, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:35:37,531 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0da61966-3964-4144-81c3-d43a9c01d1ad, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-10-31 14:35:37,532 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0da61966-3964-4144-81c3-d43a9c01d1ad, ghrun-uk32wjuvr4.auto.internal:5829): response = { <_MultiThreadedRendezvous object> }
2025-10-31 14:35:38,674 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=
2025-10-31 14:35:38,679 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_compression`, volumes `value` (8000000, 1465272)
2025-10-31 14:35:38,680 - INFO - root - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_compression` 8092160 / 1465272: 5.522633340430992
2025-10-31 14:35:38,682 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-10-31 14:35:38,683 - DEBUG - ydb.connection - _prepare_call: RpcState(DeleteSession, 6f66f908-0240-4a34-833b-528960e9ec35, ghrun-uk32wjuvr4.auto.internal:5829): creating call state
2025-10-31 14:35:38,684 - DEBUG - ydb.connection - _log_request: RpcState(DeleteSession, 6f66f908-0240-4a34-833b-528960e9ec35, ghrun-uk32wjuvr4.auto.internal:5829): request = { session_id: "ydb://session/3?node_id=1&id=YjE2MDk3NjktOTQ5ZTgzMTUtZTk0YTdlOGEtZDdjNTA2NWQ=" }
2025-10-31 14:35:38,690 - DEBUG - ydb.connection - _log_response: RpcState(DeleteSession, 6f66f908-0240-4a34-833b-528960e9ec35, ghrun-uk32wjuvr4.auto.internal:5829): response = { status: SUCCESS }
2025-10-31 14:35:38,692 - DEBUG - ydb.query.pool - stop: All session were deleted.
2025-10-31 14:35:38,693 - DEBUG - ydb.topic - close: Close topic client
2025-10-31 14:35:38,693 - DEBUG - ydb.topic - close: Topic client was closed
2025-10-31 14:35:38,694 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:5829
2025-10-31 14:35:38,697 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(AttachSession, 65cffd47-f688-4805-abf7-72f5726561cb, ghrun-uk32wjuvr4.auto.internal:5829): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.CANCELLED
	details = "Locally cancelled by application!"
	debug_error_string = "None"
>
2025-10-31 14:35:38,705 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-uk32wjuvr4.auto.internal:5829
2025-10-31 14:35:38,708 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-10-31 14:35:55,736 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:5829/1
2025-10-31 14:35:55,739 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/8164
2025-10-31 14:35:55,740 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/18453
2025-10-31 14:35:55,740 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/24430
2025-10-31 14:35:55,741 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/5829
2025-10-31 14:35:55,741 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/25234
