2025-11-21 20:42:57,110 - INFO - ya.test.671285  - pytest_runtest_setup: ####################################################################################################
2025-11-21 20:42:57,110 - INFO - ya.test.671285  - pytest_runtest_setup: test_all_supported_compression[zstd_12_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 12]
2025-11-21 20:42:57,111 - INFO - ya.test.671285  - pytest_runtest_setup: ####################################################################################################
2025-11-21 20:42:57,111 - INFO - ya.test.671285  - pytest_runtest_setup: Test setup
2025-11-21 20:42:57,113 - DEBUG - ya.test.671285  - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-21 20:42:57,114 - DEBUG - ya.test.671285  - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-21 20:42:57,114 - DEBUG - ya.test.671285  - execute: Executing '['/home/runner/.ya/build/build_root/tshh/002753/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-21 20:42:57,126 - DEBUG - ya.test.671285  - execute: Command pid: 674786
2025-11-21 20:42:57,976 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 674786) rc: 0
2025-11-21 20:42:57,977 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 674786) elapsed time (sec): 0.8485250473022461
2025-11-21 20:42:57,978 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 674786) idrss: 0
2025-11-21 20:42:57,978 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 674786) inblock: 0
2025-11-21 20:42:57,979 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 674786) isrss: 0
2025-11-21 20:42:57,979 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 674786) ixrss: 0
2025-11-21 20:42:57,979 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 674786) majflt: 0
2025-11-21 20:42:57,979 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 674786) maxrss: 493524
2025-11-21 20:42:57,980 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 674786) minflt: 45630
2025-11-21 20:42:57,980 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 674786) msgrcv: 0
2025-11-21 20:42:57,980 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 674786) msgsnd: 0
2025-11-21 20:42:57,980 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 674786) nivcsw: 159
2025-11-21 20:42:57,981 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 674786) nsignals: 0
2025-11-21 20:42:57,981 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 674786) nswap: 0
2025-11-21 20:42:57,981 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 674786) nvcsw: 15
2025-11-21 20:42:57,981 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 674786) oublock: 8
2025-11-21 20:42:57,982 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 674786) stime: 0.209255
2025-11-21 20:42:57,982 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 674786) utime: 0.521259
2025-11-21 20:42:57,982 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 674786) wtime: 0.861
2025-11-21 20:42:57,983 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 674786) output:
Arc info:
    Branch: unknown-vcs-branch
    Commit: THIS_REVISION_IS_A_DUMMY
    Author: ordinal
    Summary: No VCS
    Last Changed Rev: -1
    Last Changed Date: 2015-03-14T06:05:35.000000Z
Other info:
    Build by: runner
    Top src dir: 
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-frzglb4yoy    Host information: 
        Linux ghrun-frzglb4yoy 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

     
Build info:
    Compiler: /home/runner/.ya/tools/v4/10302026024/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10302026024/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -fsanitize=address -Daddress_sanitizer_enabled -fno-omit-frame-pointer -fsanitize-blacklist=/home/runner/actions_runner/_work/ydb/ydb/build/sanitize-blacklist.txt -fno-sanitize-link-runtime -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-11-21 20:42:57,983 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 674786) errors:

2025-11-21 20:42:57,983 - INFO - __tests__.base.671285  - _setup_ydb: Arc info:
    Branch: unknown-vcs-branch
    Commit: THIS_REVISION_IS_A_DUMMY
    Author: ordinal
    Summary: No VCS
    Last Changed Rev: -1
    Last Changed Date: 2015-03-14T06:05:35.000000Z
Other info:
    Build by: runner
    Top src dir: 
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-frzglb4yoy    Host information: 
        Linux ghrun-frzglb4yoy 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

     
Build info:
    Compiler: /home/runner/.ya/tools/v4/10302026024/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10302026024/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -fsanitize=address -Daddress_sanitizer_enabled -fno-omit-frame-pointer -fsanitize-blacklist=/home/runner/actions_runner/_work/ydb/ydb/build/sanitize-blacklist.txt -fno-sanitize-link-runtime -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-11-21 20:42:58,115 - DEBUG - ya.test.671285  - get_binary: Binary was found by /home/runner/.ya/build/build_root/tshh/002753/ydb/apps/ydbd/ydbd
2025-11-21 20:42:58,116 - DEBUG - library.python.filelock.671285  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/13835
2025-11-21 20:42:58,119 - DEBUG - ydb.tests.library.harness.kikimr_runner.671285  - start: Working directory: /home/runner/.ya/build/build_root/tshh/002753/r3tmp/kikimr_cluster_nsvi6gzg
2025-11-21 20:42:58,185 - DEBUG - ya.test.671285  - get_binary: Binary was found by /home/runner/.ya/build/build_root/tshh/002753/ydb/apps/ydbd/ydbd
2025-11-21 20:42:58,185 - DEBUG - library.python.filelock.671285  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/4219
2025-11-21 20:42:58,186 - DEBUG - library.python.filelock.671285  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/23407
2025-11-21 20:42:58,187 - DEBUG - library.python.filelock.671285  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/8145
2025-11-21 20:42:58,187 - DEBUG - library.python.filelock.671285  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/11943
2025-11-21 20:42:58,189 - INFO - ydb.tests.library.harness.kikimr_runner.671285  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/tshh/002753/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk1/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_12_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.12/cluster/kikimr_configs"
2025-11-21 20:42:58,189 - INFO - ydb.tests.library.harness.kikimr_runner.671285  - __make_run_command: Final command: /home/runner/.ya/build/build_root/tshh/002753/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=1 --log-file-name=/home/runner/.ya/build/build_root/tshh/002753/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk1/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_12_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.12/cluster/node_1/logfile_jodnc19e.log --grpc-port=4219 --mon-port=23407 --ic-port=13835
2025-11-21 20:42:58,189 - DEBUG - ydb.tests.library.harness.kikimr_runner.671285  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:4219/1, disk_size 68719476736
2025-11-21 20:42:58,190 - INFO - ydb.tests.library.harness.kikimr_runner.671285  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/tshh/002753/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk1/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_12_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.12/cluster/kikimr_configs"
2025-11-21 20:42:58,190 - INFO - ydb.tests.library.harness.kikimr_runner.671285  - __make_run_command: Final command: /home/runner/.ya/build/build_root/tshh/002753/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=1 --log-file-name=/home/runner/.ya/build/build_root/tshh/002753/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk1/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_12_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.12/cluster/node_1/logfile_jodnc19e.log --grpc-port=4219 --mon-port=23407 --ic-port=13835
2025-11-21 20:42:58,193 - DEBUG - ya.test.671285  - execute: Executing '('/home/runner/.ya/build/build_root/tshh/002753/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/tshh/002753/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk1/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_12_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.12/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/tshh/002753/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk1/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_12_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.12/cluster/node_1/logfile_jodnc19e.log', '--grpc-port=4219', '--mon-port=23407', '--ic-port=13835')' in '/home/runner/.ya/build/build_root/tshh/002753/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk1/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_12_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.12/cluster/node_1' (no wait)
2025-11-21 20:42:58,202 - DEBUG - ya.test.671285  - execute: Command pid: 675321
2025-11-21 20:42:58,204 - INFO - ydb.tests.library.harness.kikimr_runner.671285  - start: Started node localhost:4219/1
2025-11-21 20:42:58,205 - DEBUG - ya.test.671285  - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-21 20:42:58,206 - DEBUG - ya.test.671285  - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-21 20:42:58,208 - DEBUG - ya.test.671285  - execute: Executing '['/home/runner/.ya/build/build_root/tshh/002753/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-21 20:42:58,225 - DEBUG - ya.test.671285  - execute: Command pid: 675330
2025-11-21 20:42:59,022 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 675330) rc: 0
2025-11-21 20:42:59,023 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 675330) elapsed time (sec): 0.7964704036712646
2025-11-21 20:42:59,023 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 675330) idrss: 0
2025-11-21 20:42:59,023 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 675330) inblock: 0
2025-11-21 20:42:59,024 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 675330) isrss: 0
2025-11-21 20:42:59,024 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 675330) ixrss: 0
2025-11-21 20:42:59,024 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 675330) majflt: 0
2025-11-21 20:42:59,025 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 675330) maxrss: 502604
2025-11-21 20:42:59,025 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 675330) minflt: 45604
2025-11-21 20:42:59,025 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 675330) msgrcv: 0
2025-11-21 20:42:59,025 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 675330) msgsnd: 0
2025-11-21 20:42:59,026 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 675330) nivcsw: 130
2025-11-21 20:42:59,026 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 675330) nsignals: 0
2025-11-21 20:42:59,026 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 675330) nswap: 0
2025-11-21 20:42:59,026 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 675330) nvcsw: 13
2025-11-21 20:42:59,026 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 675330) oublock: 8
2025-11-21 20:42:59,026 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 675330) stime: 0.24627
2025-11-21 20:42:59,027 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 675330) utime: 0.435714
2025-11-21 20:42:59,027 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 675330) wtime: 0.814
2025-11-21 20:42:59,027 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 675330) output:
Arc info:
    Branch: unknown-vcs-branch
    Commit: THIS_REVISION_IS_A_DUMMY
    Author: ordinal
    Summary: No VCS
    Last Changed Rev: -1
    Last Changed Date: 2015-03-14T06:05:35.000000Z
Other info:
    Build by: runner
    Top src dir: 
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-frzglb4yoy    Host information: 
        Linux ghrun-frzglb4yoy 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

     
Build info:
    Compiler: /home/runner/.ya/tools/v4/10302026024/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10302026024/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -fsanitize=address -Daddress_sanitizer_enabled -fno-omit-frame-pointer -fsanitize-blacklist=/home/runner/actions_runner/_work/ydb/ydb/build/sanitize-blacklist.txt -fno-sanitize-link-runtime -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-11-21 20:42:59,028 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 675330) errors:

2025-11-21 20:42:59,028 - INFO - ydb.tests.library.harness.kikimr_runner.671285  - start: Node 1 version:
Arc info:
    Branch: unknown-vcs-branch
    Commit: THIS_REVISION_IS_A_DUMMY
    Author: ordinal
    Summary: No VCS
    Last Changed Rev: -1
    Last Changed Date: 2015-03-14T06:05:35.000000Z
Other info:
    Build by: runner
    Top src dir: 
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-frzglb4yoy    Host information: 
        Linux ghrun-frzglb4yoy 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64
2025-11-21 20:43:04,016 - DEBUG - ya.test.671285  - get_binary: Binary was found by /home/runner/.ya/build/build_root/tshh/002753/ydb/apps/ydbd/ydbd
2025-11-21 20:43:04,017 - DEBUG - ydb.tests.library.harness.kikimr_runner.671285  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/tshh/002753/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:4219', '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: 13835\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-21 20:43:04,018 - DEBUG - ya.test.671285  - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-21 20:43:04,019 - DEBUG - ya.test.671285  - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-21 20:43:04,019 - DEBUG - ya.test.671285  - execute: Executing '['/home/runner/.ya/build/build_root/tshh/002753/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:4219', '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: 13835\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-21 20:43:04,027 - DEBUG - ya.test.671285  - execute: Command pid: 679043
2025-11-21 20:43:04,915 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679043) rc: 0
2025-11-21 20:43:04,916 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679043) elapsed time (sec): 0.8871994018554688
2025-11-21 20:43:04,916 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679043) idrss: 0
2025-11-21 20:43:04,916 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679043) inblock: 0
2025-11-21 20:43:04,916 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679043) isrss: 0
2025-11-21 20:43:04,917 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679043) ixrss: 0
2025-11-21 20:43:04,917 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679043) majflt: 0
2025-11-21 20:43:04,917 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679043) maxrss: 590732
2025-11-21 20:43:04,917 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679043) minflt: 51861
2025-11-21 20:43:04,918 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679043) msgrcv: 0
2025-11-21 20:43:04,918 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679043) msgsnd: 0
2025-11-21 20:43:04,918 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679043) nivcsw: 110
2025-11-21 20:43:04,918 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679043) nsignals: 0
2025-11-21 20:43:04,927 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679043) nswap: 0
2025-11-21 20:43:04,927 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679043) nvcsw: 696
2025-11-21 20:43:04,928 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679043) oublock: 8
2025-11-21 20:43:04,928 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679043) stime: 0.29364999999999997
2025-11-21 20:43:04,928 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679043) utime: 0.520211
2025-11-21 20:43:04,929 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679043) wtime: 0.895
2025-11-21 20:43:04,929 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679043) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-21 20:43:04,929 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679043) errors:

2025-11-21 20:43:04,940 - DEBUG - ya.test.671285  - get_binary: Binary was found by /home/runner/.ya/build/build_root/tshh/002753/ydb/apps/ydbd/ydbd
2025-11-21 20:43:04,941 - DEBUG - ydb.tests.library.harness.kikimr_runner.671285  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/tshh/002753/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:4219', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']
2025-11-21 20:43:04,942 - DEBUG - ya.test.671285  - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-21 20:43:04,943 - DEBUG - ya.test.671285  - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-21 20:43:04,943 - DEBUG - ya.test.671285  - execute: Executing '['/home/runner/.ya/build/build_root/tshh/002753/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:4219', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-21 20:43:04,960 - DEBUG - ya.test.671285  - execute: Command pid: 679322
2025-11-21 20:43:05,865 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679322) rc: 0
2025-11-21 20:43:05,865 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679322) elapsed time (sec): 0.9035706520080566
2025-11-21 20:43:05,865 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679322) idrss: 0
2025-11-21 20:43:05,866 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679322) inblock: 0
2025-11-21 20:43:05,866 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679322) isrss: 0
2025-11-21 20:43:05,866 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679322) ixrss: 0
2025-11-21 20:43:05,866 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679322) majflt: 0
2025-11-21 20:43:05,866 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679322) maxrss: 590780
2025-11-21 20:43:05,866 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679322) minflt: 51993
2025-11-21 20:43:05,867 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679322) msgrcv: 0
2025-11-21 20:43:05,867 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679322) msgsnd: 0
2025-11-21 20:43:05,867 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679322) nivcsw: 131
2025-11-21 20:43:05,867 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679322) nsignals: 0
2025-11-21 20:43:05,868 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679322) nswap: 0
2025-11-21 20:43:05,868 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679322) nvcsw: 640
2025-11-21 20:43:05,868 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679322) oublock: 8
2025-11-21 20:43:05,868 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679322) stime: 0.252222
2025-11-21 20:43:05,868 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679322) utime: 0.5285219999999999
2025-11-21 20:43:05,869 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679322) wtime: 0.921
2025-11-21 20:43:05,869 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679322) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-11-21 20:43:05,869 - DEBUG - ya.test.671285  - _save_outputs: Command (pid 679322) errors:

2025-11-21 20:43:05,870 - INFO - ydb.tests.library.harness.kikimr_runner.671285  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-21 20:43:06,017 - INFO - ydb.tests.library.harness.kikimr_runner.671285  - __run: Cluster started and initialized
2025-11-21 20:43:06,075 - DEBUG - ydb.connection.671285  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-21 20:43:06,079 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.671285  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-21 20:43:06,079 - DEBUG - ydb.connection.671285  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-21 20:43:06,103 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.671285  - context_resolve: Resolving endpoints for database /Root
2025-11-21 20:43:06,103 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ListEndpoints, b0fc77f0-f201-427f-99b5-641efe1a40ec, localhost:4219): creating call state
2025-11-21 20:43:06,104 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ListEndpoints, b0fc77f0-f201-427f-99b5-641efe1a40ec, localhost:4219): request = { database: "/Root" }
2025-11-21 20:43:06,114 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ListEndpoints, b0fc77f0-f201-427f-99b5-641efe1a40ec, localhost:4219): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-frzglb4yoy.auto.internal" port: 4219 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-11-21 20:43:06,115 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.671285  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-frzglb4yoy.auto.internal:4219, location 1, ssl: False>]>
2025-11-21 20:43:06,116 - DEBUG - ydb.connection.671285  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-21 20:43:06,131 - DEBUG - ydb.connection.671285  - close: Closing channel for endpoint localhost:4219
2025-11-21 20:43:06,135 - DEBUG - ydb.query.pool.671285  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-21 20:43:06,136 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(CreateSession, 1a450372-3d43-48ca-9170-6962b3b52c93, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:06,137 - DEBUG - ydb.connection.671285  - _log_request: RpcState(CreateSession, 1a450372-3d43-48ca-9170-6962b3b52c93, ghrun-frzglb4yoy.auto.internal:4219): request = {  }
2025-11-21 20:43:06,148 - DEBUG - ydb.connection.671285  - _log_response: RpcState(CreateSession, 1a450372-3d43-48ca-9170-6962b3b52c93, ghrun-frzglb4yoy.auto.internal:4219): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" node_id: 1 }
2025-11-21 20:43:06,149 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(AttachSession, a2e5af93-5bc7-4294-a614-5a73060e921d, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:06,150 - DEBUG - ydb.connection.671285  - _log_request: RpcState(AttachSession, a2e5af93-5bc7-4294-a614-5a73060e921d, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" }
2025-11-21 20:43:06,160 - DEBUG - ydb.connection.671285  - _log_response: RpcState(AttachSession, a2e5af93-5bc7-4294-a614-5a73060e921d, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:06,170 - DEBUG - ydb.query.pool.671285  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:06,171 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 2c3ab30e-de41-461f-aa1f-14a777c39c1c, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:06,172 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 2c3ab30e-de41-461f-aa1f-14a777c39c1c, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/off_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"off\")\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:06,173 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 2c3ab30e-de41-461f-aa1f-14a777c39c1c, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:08,245 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:08,246 - INFO - __tests__.alter_compression.671285  - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-11-21 20:43:08,247 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:08,248 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 78ec1432-f3b1-422c-9e30-008c0e67fe68, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:08,249 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 78ec1432-f3b1-422c-9e30-008c0e67fe68, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/off_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:08,251 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 78ec1432-f3b1-422c-9e30-008c0e67fe68, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:09,111 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:09,112 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:09,113 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 3adcd463-c913-4cd8-ac41-c5fa7095bbc0, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:09,114 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 3adcd463-c913-4cd8-ac41-c5fa7095bbc0, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 0;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:09,115 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 3adcd463-c913-4cd8-ac41-c5fa7095bbc0, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:09,990 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:09,991 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:09,991 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 8cc81e34-83b4-40ce-90c9-7ed465e605ea, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:09,992 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 8cc81e34-83b4-40ce-90c9-7ed465e605ea, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:09,993 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 8cc81e34-83b4-40ce-90c9-7ed465e605ea, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:10,650 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:10,651 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:10,652 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 1a5cd12e-48a2-46bf-a975-85e5c52d44cb, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:10,652 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 1a5cd12e-48a2-46bf-a975-85e5c52d44cb, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:10,654 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 1a5cd12e-48a2-46bf-a975-85e5c52d44cb, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:11,836 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:11,837 - INFO - __tests__.alter_compression.671285  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 1618432, 'BlobCount': 128}}
2025-11-21 20:43:11,837 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:11,838 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 46c7f0f0-bef2-4e20-ac1b-5820063e1d83, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:11,839 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 46c7f0f0-bef2-4e20-ac1b-5820063e1d83, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 100000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:11,840 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 46c7f0f0-bef2-4e20-ac1b-5820063e1d83, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:12,696 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:12,697 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:12,698 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, dd9455d9-a4b6-4683-9b28-98898ef4e8bf, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:12,698 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, dd9455d9-a4b6-4683-9b28-98898ef4e8bf, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:12,700 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, dd9455d9-a4b6-4683-9b28-98898ef4e8bf, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:12,878 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:12,879 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:12,880 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, c9757b96-9c04-496f-af83-6ebec8b81112, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:12,880 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, c9757b96-9c04-496f-af83-6ebec8b81112, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:12,882 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, c9757b96-9c04-496f-af83-6ebec8b81112, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:13,125 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:13,126 - INFO - __tests__.alter_compression.671285  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 3236864, 'BlobCount': 256}}
2025-11-21 20:43:13,126 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:13,127 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 0fa30984-b73f-48bf-beeb-d83760e70539, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:13,127 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 0fa30984-b73f-48bf-beeb-d83760e70539, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 200000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:13,128 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 0fa30984-b73f-48bf-beeb-d83760e70539, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:13,943 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:13,944 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:13,945 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 6940a6e3-0325-43d5-b82b-e91d3c7d69e4, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:13,946 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 6940a6e3-0325-43d5-b82b-e91d3c7d69e4, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:13,947 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 6940a6e3-0325-43d5-b82b-e91d3c7d69e4, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:14,116 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:14,117 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:14,118 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 2aa47dce-faf3-4896-b8dd-7555231fc760, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:14,118 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 2aa47dce-faf3-4896-b8dd-7555231fc760, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:14,120 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 2aa47dce-faf3-4896-b8dd-7555231fc760, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:14,396 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:14,396 - INFO - __tests__.alter_compression.671285  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 4855296, 'BlobCount': 384}}
2025-11-21 20:43:14,397 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:14,398 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, cb4e43cf-360e-4b76-bc88-a7a316983e83, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:14,399 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, cb4e43cf-360e-4b76-bc88-a7a316983e83, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 300000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:14,400 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, cb4e43cf-360e-4b76-bc88-a7a316983e83, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:15,323 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:15,324 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:15,325 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 6d9388ea-999b-468e-baab-f60e06b9ee21, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:15,326 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 6d9388ea-999b-468e-baab-f60e06b9ee21, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:15,327 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 6d9388ea-999b-468e-baab-f60e06b9ee21, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:15,499 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:15,500 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:15,500 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 81e46f0c-23d5-4935-b7d1-a6adcec65375, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:15,501 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 81e46f0c-23d5-4935-b7d1-a6adcec65375, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:15,502 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 81e46f0c-23d5-4935-b7d1-a6adcec65375, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:15,803 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:15,804 - INFO - __tests__.alter_compression.671285  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 6473728, 'BlobCount': 512}}
2025-11-21 20:43:15,804 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:15,805 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 0d0d5e44-8d9b-4d2d-963f-c8e40e39da58, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:15,806 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 0d0d5e44-8d9b-4d2d-963f-c8e40e39da58, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 400000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:15,807 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 0d0d5e44-8d9b-4d2d-963f-c8e40e39da58, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:16,527 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:16,528 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:16,529 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 8c3b08bb-c0be-4ba8-8226-414ad19effcd, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:16,529 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 8c3b08bb-c0be-4ba8-8226-414ad19effcd, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:16,530 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 8c3b08bb-c0be-4ba8-8226-414ad19effcd, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:16,700 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:16,701 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:16,702 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, d6558f4e-429d-4b9f-a5b8-8d37c53f1a5f, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:16,703 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, d6558f4e-429d-4b9f-a5b8-8d37c53f1a5f, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:16,704 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, d6558f4e-429d-4b9f-a5b8-8d37c53f1a5f, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:17,023 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:17,024 - INFO - __tests__.alter_compression.671285  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 8092160, 'BlobCount': 640}}
2025-11-21 20:43:17,025 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:17,025 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 2da525d5-e4f1-4e3c-800b-04d9f7c08084, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:17,026 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 2da525d5-e4f1-4e3c-800b-04d9f7c08084, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 500000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:17,028 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 2da525d5-e4f1-4e3c-800b-04d9f7c08084, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:17,805 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:17,806 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:17,806 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, da0e77d0-50fe-4f0a-a7ab-3fc8d77fab6b, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:17,807 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, da0e77d0-50fe-4f0a-a7ab-3fc8d77fab6b, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:17,808 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, da0e77d0-50fe-4f0a-a7ab-3fc8d77fab6b, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:18,033 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:18,034 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:18,035 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 9bb3e9f6-9fab-462c-8b41-725428e59722, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:18,036 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 9bb3e9f6-9fab-462c-8b41-725428e59722, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:18,037 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 9bb3e9f6-9fab-462c-8b41-725428e59722, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:18,387 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:18,388 - INFO - __tests__.alter_compression.671285  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 9710592, 'BlobCount': 768}}
2025-11-21 20:43:18,388 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:18,389 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 43293b1f-3de9-44c4-be7a-df6d08e44423, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:18,390 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 43293b1f-3de9-44c4-be7a-df6d08e44423, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 600000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:18,392 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 43293b1f-3de9-44c4-be7a-df6d08e44423, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:19,118 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:19,119 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:19,120 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, aece0eec-1612-44bd-9364-fdb178eada1d, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:19,120 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, aece0eec-1612-44bd-9364-fdb178eada1d, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:19,121 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, aece0eec-1612-44bd-9364-fdb178eada1d, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:19,310 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:19,311 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:19,312 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 5b766a01-4a54-4ba3-998e-b54626e3d19b, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:19,313 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 5b766a01-4a54-4ba3-998e-b54626e3d19b, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:19,314 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 5b766a01-4a54-4ba3-998e-b54626e3d19b, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:19,752 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:19,753 - INFO - __tests__.alter_compression.671285  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 11329024, 'BlobCount': 896}}
2025-11-21 20:43:19,753 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:19,754 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, e0242604-79bc-4be3-ba6f-49928aca2f4f, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:19,755 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, e0242604-79bc-4be3-ba6f-49928aca2f4f, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 700000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:19,756 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, e0242604-79bc-4be3-ba6f-49928aca2f4f, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:20,559 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:20,560 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:20,560 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, cd09a017-9c6a-420c-9f19-bb676b785700, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:20,561 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, cd09a017-9c6a-420c-9f19-bb676b785700, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:20,564 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, cd09a017-9c6a-420c-9f19-bb676b785700, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:20,767 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:20,768 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:20,769 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 601a76a3-ccc0-4a53-807d-4f04466f238f, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:20,770 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 601a76a3-ccc0-4a53-807d-4f04466f238f, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:20,772 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 601a76a3-ccc0-4a53-807d-4f04466f238f, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:21,238 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:21,238 - INFO - __tests__.alter_compression.671285  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 12947456, 'BlobCount': 1024}}
2025-11-21 20:43:21,239 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:21,240 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, a79214f5-e823-416a-ac1d-74fdf8445d0c, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:21,240 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, a79214f5-e823-416a-ac1d-74fdf8445d0c, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 800000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:21,242 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, a79214f5-e823-416a-ac1d-74fdf8445d0c, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:22,165 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:22,165 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:22,166 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, ba9f7b71-72c4-4e97-a445-c88969b483b8, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:22,167 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, ba9f7b71-72c4-4e97-a445-c88969b483b8, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:22,168 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, ba9f7b71-72c4-4e97-a445-c88969b483b8, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:22,370 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:22,371 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:22,371 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 6d024040-1f33-43cb-bb74-3f1ed88e129e, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:22,372 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 6d024040-1f33-43cb-bb74-3f1ed88e129e, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:22,373 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 6d024040-1f33-43cb-bb74-3f1ed88e129e, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:22,935 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:22,936 - INFO - __tests__.alter_compression.671285  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 14565888, 'BlobCount': 1152}}
2025-11-21 20:43:22,936 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:22,937 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 25706da5-b80e-485e-a10f-be30fafdd0f6, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:22,938 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 25706da5-b80e-485e-a10f-be30fafdd0f6, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 900000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:22,940 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 25706da5-b80e-485e-a10f-be30fafdd0f6, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:23,896 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:23,897 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:23,897 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 3eae6e54-524f-4cd9-a63b-4a484ad57439, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:23,898 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 3eae6e54-524f-4cd9-a63b-4a484ad57439, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:23,900 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 3eae6e54-524f-4cd9-a63b-4a484ad57439, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:24,088 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:24,089 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:24,090 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 2c3c875a-1808-4f18-8899-4bfd60a1d0ea, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:24,091 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 2c3c875a-1808-4f18-8899-4bfd60a1d0ea, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:24,092 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 2c3c875a-1808-4f18-8899-4bfd60a1d0ea, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:24,666 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:24,667 - INFO - __tests__.alter_compression.671285  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 16184320, 'BlobCount': 1280}}
2025-11-21 20:43:24,667 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:24,668 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 97be0108-fb19-49b7-a150-8e445b49e994, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:24,669 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 97be0108-fb19-49b7-a150-8e445b49e994, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/off_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:24,670 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 97be0108-fb19-49b7-a150-8e445b49e994, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:25,674 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:25,675 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:25,675 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 7281250b-eff8-4918-b4ff-a96c7cbf90db, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:25,676 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 7281250b-eff8-4918-b4ff-a96c7cbf90db, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:25,678 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 7281250b-eff8-4918-b4ff-a96c7cbf90db, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:25,912 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:25,913 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:25,914 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 18c19498-c86d-4e93-a904-1fa360168912, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:25,915 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 18c19498-c86d-4e93-a904-1fa360168912, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:25,916 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 18c19498-c86d-4e93-a904-1fa360168912, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:26,112 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:26,113 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:26,113 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 92fda4b9-b2ae-4d56-a94b-1bc66208b889, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:26,114 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 92fda4b9-b2ae-4d56-a94b-1bc66208b889, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:26,115 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 92fda4b9-b2ae-4d56-a94b-1bc66208b889, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:29,278 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:39,313 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:39,314 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, ef9ca61f-46f2-42bd-9ae9-3caa4ff12fcd, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:39,315 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, ef9ca61f-46f2-42bd-9ae9-3caa4ff12fcd, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:39,316 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, ef9ca61f-46f2-42bd-9ae9-3caa4ff12fcd, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:41,814 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:41,853 - INFO - root.671285  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-21 20:43:41,854 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:41,855 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 97be8e72-3f41-40c1-97e6-5196d33589a3, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:41,855 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 97be8e72-3f41-40c1-97e6-5196d33589a3, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:41,857 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 97be8e72-3f41-40c1-97e6-5196d33589a3, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:44,136 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:54,184 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:54,185 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 91c71f7f-9bb6-4e28-99f0-5c6b0931f62d, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:54,186 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 91c71f7f-9bb6-4e28-99f0-5c6b0931f62d, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:54,187 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 91c71f7f-9bb6-4e28-99f0-5c6b0931f62d, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:56,696 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:56,727 - INFO - root.671285  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-21 20:43:56,728 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:56,728 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 118ee970-d772-4c7d-8cbb-f3c2af199c7b, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:56,729 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 118ee970-d772-4c7d-8cbb-f3c2af199c7b, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:56,730 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 118ee970-d772-4c7d-8cbb-f3c2af199c7b, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:56,939 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:56,942 - INFO - ya.test.671285  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_12_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 12])
2025-11-21 20:43:56,943 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:56,943 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 0f63ad1c-5f1c-4793-8624-9b69cf74ae3b, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:56,944 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 0f63ad1c-5f1c-4793-8624-9b69cf74ae3b, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_12_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 12)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:56,946 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 0f63ad1c-5f1c-4793-8624-9b69cf74ae3b, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:59,209 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:59,210 - INFO - __tests__.alter_compression.671285  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_12_compression created
2025-11-21 20:43:59,210 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:59,211 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 6cd5c5df-69b9-4bb5-be97-44794b3d3b39, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:59,212 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 6cd5c5df-69b9-4bb5-be97-44794b3d3b39, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_12_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:59,213 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 6cd5c5df-69b9-4bb5-be97-44794b3d3b39, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:43:59,904 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:59,905 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:43:59,905 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 3503f6d4-e4d9-4362-b8a0-f03557ad6fe6, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:43:59,906 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 3503f6d4-e4d9-4362-b8a0-f03557ad6fe6, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:43:59,907 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 3503f6d4-e4d9-4362-b8a0-f03557ad6fe6, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:02,241 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:02,242 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:02,243 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 943ed63a-e36b-4ca0-944e-7c7d341853de, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:02,244 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 943ed63a-e36b-4ca0-944e-7c7d341853de, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:02,245 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 943ed63a-e36b-4ca0-944e-7c7d341853de, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:03,204 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:03,205 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:03,206 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, c24199b3-a529-4389-b1aa-15813754873d, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:03,207 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, c24199b3-a529-4389-b1aa-15813754873d, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:03,209 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, c24199b3-a529-4389-b1aa-15813754873d, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:04,795 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:04,796 - INFO - __tests__.alter_compression.671285  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 375776, 'BlobCount': 128}}
2025-11-21 20:44:04,796 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:04,797 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, e5a61934-65e7-4953-b633-0560bd87c690, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:04,798 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, e5a61934-65e7-4953-b633-0560bd87c690, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:04,799 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, e5a61934-65e7-4953-b633-0560bd87c690, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:07,134 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:07,135 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:07,135 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, f3129310-5223-4adc-b645-701a49261764, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:07,136 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, f3129310-5223-4adc-b645-701a49261764, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:07,138 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, f3129310-5223-4adc-b645-701a49261764, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:07,403 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:07,404 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:07,405 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, b20d0a6c-b907-4284-a695-d02c534b0ffe, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:07,406 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, b20d0a6c-b907-4284-a695-d02c534b0ffe, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:07,407 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, b20d0a6c-b907-4284-a695-d02c534b0ffe, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:07,731 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:07,732 - INFO - __tests__.alter_compression.671285  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 753024, 'BlobCount': 256}}
2025-11-21 20:44:07,732 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:07,733 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 1c005d70-a45c-4442-80e4-d9f19aba40a9, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:07,734 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 1c005d70-a45c-4442-80e4-d9f19aba40a9, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:07,735 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 1c005d70-a45c-4442-80e4-d9f19aba40a9, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:10,156 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:10,156 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:10,157 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 30619517-6569-46e8-a8ad-65b503d1d844, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:10,158 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 30619517-6569-46e8-a8ad-65b503d1d844, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:10,159 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 30619517-6569-46e8-a8ad-65b503d1d844, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:10,494 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:10,520 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:10,521 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 6109b905-bd9f-4558-9337-efdb31c674cd, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:10,521 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 6109b905-bd9f-4558-9337-efdb31c674cd, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:10,523 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 6109b905-bd9f-4558-9337-efdb31c674cd, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:11,004 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:11,004 - INFO - __tests__.alter_compression.671285  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 1129904, 'BlobCount': 384}}
2025-11-21 20:44:11,005 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:11,005 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, bcb6539f-e23c-47f0-89f2-c27cd6273e9e, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:11,006 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, bcb6539f-e23c-47f0-89f2-c27cd6273e9e, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:11,008 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, bcb6539f-e23c-47f0-89f2-c27cd6273e9e, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:13,441 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:13,442 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:13,443 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, bd6f03d5-1ec8-4237-a82e-aa03129a68d2, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:13,444 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, bd6f03d5-1ec8-4237-a82e-aa03129a68d2, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:13,445 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, bd6f03d5-1ec8-4237-a82e-aa03129a68d2, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:13,771 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:13,772 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:13,772 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 68ed7a6b-68dc-4171-829d-58fe115ffe42, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:13,773 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 68ed7a6b-68dc-4171-829d-58fe115ffe42, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:13,775 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 68ed7a6b-68dc-4171-829d-58fe115ffe42, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:14,367 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:14,368 - INFO - __tests__.alter_compression.671285  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1507088, 'BlobCount': 512}}
2025-11-21 20:44:14,368 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:14,369 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 59a9aa35-5efd-4bde-be91-66711f070d98, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:14,370 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 59a9aa35-5efd-4bde-be91-66711f070d98, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:14,376 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 59a9aa35-5efd-4bde-be91-66711f070d98, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:16,920 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:16,921 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:16,922 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, c25989c4-d27d-4b44-be79-a3920d8b206d, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:16,923 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, c25989c4-d27d-4b44-be79-a3920d8b206d, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:16,924 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, c25989c4-d27d-4b44-be79-a3920d8b206d, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:17,156 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:17,157 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:17,158 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 236c635d-803d-4569-ad7a-b482998cf3a3, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:17,159 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 236c635d-803d-4569-ad7a-b482998cf3a3, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:17,160 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 236c635d-803d-4569-ad7a-b482998cf3a3, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:17,591 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:17,592 - INFO - __tests__.alter_compression.671285  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1883952, 'BlobCount': 640}}
2025-11-21 20:44:17,592 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:17,593 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, dbbee22c-b296-4e8d-9915-74fd89441349, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:17,594 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, dbbee22c-b296-4e8d-9915-74fd89441349, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:17,599 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, dbbee22c-b296-4e8d-9915-74fd89441349, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:19,860 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:19,861 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:19,861 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 06c91448-1a9b-480e-81e9-3e523216174a, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:19,862 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 06c91448-1a9b-480e-81e9-3e523216174a, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:19,864 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 06c91448-1a9b-480e-81e9-3e523216174a, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:20,183 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:20,184 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:20,185 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, aa35a689-4268-4153-a98a-0d7e186b0860, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:20,186 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, aa35a689-4268-4153-a98a-0d7e186b0860, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:20,187 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, aa35a689-4268-4153-a98a-0d7e186b0860, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:20,671 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:20,672 - INFO - __tests__.alter_compression.671285  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 2261152, 'BlobCount': 768}}
2025-11-21 20:44:20,672 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:20,673 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, ae00c963-e84b-47f8-991f-5a4f9b11ae54, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:20,674 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, ae00c963-e84b-47f8-991f-5a4f9b11ae54, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:20,676 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, ae00c963-e84b-47f8-991f-5a4f9b11ae54, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:22,919 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:22,919 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:22,920 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 3fc6b3a3-b38b-4e72-b2be-5c7ee6dd61f3, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:22,921 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 3fc6b3a3-b38b-4e72-b2be-5c7ee6dd61f3, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:22,922 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 3fc6b3a3-b38b-4e72-b2be-5c7ee6dd61f3, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:23,268 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:23,269 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:23,270 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 02043382-a6b3-48c3-8175-b3da6e99ebd4, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:23,271 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 02043382-a6b3-48c3-8175-b3da6e99ebd4, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:23,272 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 02043382-a6b3-48c3-8175-b3da6e99ebd4, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:23,778 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:23,778 - INFO - __tests__.alter_compression.671285  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2638128, 'BlobCount': 896}}
2025-11-21 20:44:23,779 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:23,780 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 8344ebc5-0133-4a95-9e15-fdd6de0ff63a, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:23,781 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 8344ebc5-0133-4a95-9e15-fdd6de0ff63a, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:23,782 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 8344ebc5-0133-4a95-9e15-fdd6de0ff63a, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:26,022 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:26,022 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:26,023 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 53263d69-98f6-4d07-8016-031b00351357, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:26,024 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 53263d69-98f6-4d07-8016-031b00351357, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:26,025 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 53263d69-98f6-4d07-8016-031b00351357, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:26,277 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:26,278 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:26,279 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 03715248-4f6b-449c-9d20-b3dffd5fa280, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:26,280 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 03715248-4f6b-449c-9d20-b3dffd5fa280, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:26,283 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 03715248-4f6b-449c-9d20-b3dffd5fa280, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:27,069 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:27,070 - INFO - __tests__.alter_compression.671285  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 3015296, 'BlobCount': 1024}}
2025-11-21 20:44:27,070 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:27,071 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, ccfa1e20-9fd5-4d6b-b379-e00aebcf0953, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:27,072 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, ccfa1e20-9fd5-4d6b-b379-e00aebcf0953, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:27,073 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, ccfa1e20-9fd5-4d6b-b379-e00aebcf0953, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:29,573 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:29,573 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:29,574 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 1a2a9aaf-2642-4bcb-97ef-69263b8856a3, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:29,575 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 1a2a9aaf-2642-4bcb-97ef-69263b8856a3, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:29,576 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 1a2a9aaf-2642-4bcb-97ef-69263b8856a3, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:30,011 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:30,012 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:30,013 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, ca5525b4-e19d-4350-9575-c87c939595c2, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:30,014 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, ca5525b4-e19d-4350-9575-c87c939595c2, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:30,022 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, ca5525b4-e19d-4350-9575-c87c939595c2, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:31,023 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:31,024 - INFO - __tests__.alter_compression.671285  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 3392304, 'BlobCount': 1152}}
2025-11-21 20:44:31,024 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:31,025 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 3e445075-e6f5-4ddc-bf6e-e87a776fa255, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:31,026 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 3e445075-e6f5-4ddc-bf6e-e87a776fa255, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:31,028 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 3e445075-e6f5-4ddc-bf6e-e87a776fa255, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:35,020 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:35,020 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:35,021 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 417119c9-007f-4a48-8ad9-1de809bf7c5d, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:35,022 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 417119c9-007f-4a48-8ad9-1de809bf7c5d, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:35,023 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 417119c9-007f-4a48-8ad9-1de809bf7c5d, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:35,691 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:35,692 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:35,693 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 8923a941-e455-4b54-9465-d705ddca22ba, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:35,694 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 8923a941-e455-4b54-9465-d705ddca22ba, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:35,695 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 8923a941-e455-4b54-9465-d705ddca22ba, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:36,996 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:36,997 - INFO - __tests__.alter_compression.671285  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_12_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3769616, 'BlobCount': 1280}}
2025-11-21 20:44:36,998 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:36,998 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 194a0243-9735-4574-b216-dafc9326a155, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:36,999 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 194a0243-9735-4574-b216-dafc9326a155, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_12_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:37,000 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 194a0243-9735-4574-b216-dafc9326a155, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:39,298 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:39,299 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:39,299 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 4f9d0e67-ae74-4bd6-bc54-10e05bb11fee, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:39,300 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 4f9d0e67-ae74-4bd6-bc54-10e05bb11fee, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:39,301 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 4f9d0e67-ae74-4bd6-bc54-10e05bb11fee, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:39,844 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:39,844 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:39,845 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 1845dd92-c2f1-432a-96be-f5b71564f1c8, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:39,846 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 1845dd92-c2f1-432a-96be-f5b71564f1c8, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:39,856 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 1845dd92-c2f1-432a-96be-f5b71564f1c8, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:40,364 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:40,365 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:40,366 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, d2186a39-257a-4d32-9d47-4a90b6e6e46c, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:40,367 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, d2186a39-257a-4d32-9d47-4a90b6e6e46c, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_12_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:40,375 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, d2186a39-257a-4d32-9d47-4a90b6e6e46c, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:44:45,867 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:55,962 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:44:55,963 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, e27780f7-fa6e-4b6f-a9ca-7685a9b7a75a, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:44:55,966 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, e27780f7-fa6e-4b6f-a9ca-7685a9b7a75a, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_12_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:44:55,967 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, e27780f7-fa6e-4b6f-a9ca-7685a9b7a75a, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:45:04,053 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:45:06,237 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.671285  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-21 20:45:06,238 - DEBUG - ydb.connection.671285  - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-21 20:45:06,277 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.671285  - context_resolve: Resolving endpoints for database /Root
2025-11-21 20:45:06,278 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ListEndpoints, b0b79982-1e59-44dd-b1b3-6cf81a5dc4dc, localhost:4219): creating call state
2025-11-21 20:45:06,279 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ListEndpoints, b0b79982-1e59-44dd-b1b3-6cf81a5dc4dc, localhost:4219): request = { database: "/Root" }
2025-11-21 20:45:06,286 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ListEndpoints, b0b79982-1e59-44dd-b1b3-6cf81a5dc4dc, localhost:4219): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-frzglb4yoy.auto.internal" port: 4219 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-11-21 20:45:06,287 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.671285  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-frzglb4yoy.auto.internal:4219, location 1, ssl: False>]>
2025-11-21 20:45:06,288 - DEBUG - ydb.connection.671285  - close: Closing channel for endpoint localhost:4219
2025-11-21 20:45:14,159 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:45:14,160 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, f95f31d6-2944-4796-ad1e-6eabffd69a21, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:45:14,161 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, f95f31d6-2944-4796-ad1e-6eabffd69a21, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_12_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:45:14,162 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, f95f31d6-2944-4796-ad1e-6eabffd69a21, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:45:18,019 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:45:28,079 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:45:28,080 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, cd592ba4-ec6b-4c2a-b2fb-390ff7ff9beb, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:45:28,080 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, cd592ba4-ec6b-4c2a-b2fb-390ff7ff9beb, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_12_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:45:28,082 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, cd592ba4-ec6b-4c2a-b2fb-390ff7ff9beb, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:45:29,552 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:45:39,572 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:45:39,573 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 97f8ebd0-0b99-4af2-93a6-95937a0a5311, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:45:39,574 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 97f8ebd0-0b99-4af2-93a6-95937a0a5311, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_12_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:45:39,576 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 97f8ebd0-0b99-4af2-93a6-95937a0a5311, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:45:41,341 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:45:51,349 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:45:51,350 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, d747398f-101f-4913-9ff6-222aaea19bca, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:45:51,351 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, d747398f-101f-4913-9ff6-222aaea19bca, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_12_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:45:51,352 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, d747398f-101f-4913-9ff6-222aaea19bca, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:45:53,500 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:45:53,505 - INFO - root.671285  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_12_compression`, volumes `value` (8000000, 1465648)
2025-11-21 20:45:53,505 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:45:53,506 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, a054599d-4447-40fa-add5-1943b1ab369d, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:45:53,524 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, a054599d-4447-40fa-add5-1943b1ab369d, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" 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_12_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:45:53,525 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, a054599d-4447-40fa-add5-1943b1ab369d, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:45:54,391 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:45:54,392 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:45:54,393 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 51dd69c0-6bfa-4024-bdb4-5404fab29a6d, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:45:54,394 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 51dd69c0-6bfa-4024-bdb4-5404fab29a6d, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_12_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:45:54,401 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 51dd69c0-6bfa-4024-bdb4-5404fab29a6d, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:45:55,443 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:46:05,451 - DEBUG - ydb.query.pool.671285  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:46:05,452 - DEBUG - ydb.connection.671285  - _prepare_call: RpcState(ExecuteQuery, 1c14cfa0-61ce-4f28-8543-38f1060b92df, ghrun-frzglb4yoy.auto.internal:4219): creating call state
2025-11-21 20:46:05,453 - DEBUG - ydb.connection.671285  - _log_request: RpcState(ExecuteQuery, 1c14cfa0-61ce-4f28-8543-38f1060b92df, ghrun-frzglb4yoy.auto.internal:4219): request = { session_id: "ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_12_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 20:46:05,454 - DEBUG - ydb.connection.671285  - _log_response: RpcState(ExecuteQuery, 1c14cfa0-61ce-4f28-8543-38f1060b92df, ghrun-frzglb4yoy.auto.internal:4219): response = { <_MultiThreadedRendezvous object> }
2025-11-21 20:46:06,916 - DEBUG - ydb.query.pool.671285  - release: Session returned to queue: ydb://session/3?node_id=1&id=NmQ1MGU5OWUtOTEzNWM1MGEtOGQ5MTM5ZTMtMTcxZDRhZTE=
2025-11-21 20:46:06,925 - INFO - root.671285  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_12_compression`, volumes `value` (8000000, 1465648)
2025-11-21 20:46:06,926 - INFO - root.671285  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_12_compression` 8092160 / 1465648: 5.52121655404299
2025-11-21 20:46:06,933 - INFO - ya.test.671285  - pytest_runtest_teardown: Test teardown
