2025-11-21 14:05:49,176 - INFO - ya.test.1140674  - pytest_runtest_setup: ####################################################################################################
2025-11-21 14:05:49,177 - INFO - ya.test.1140674  - pytest_runtest_setup: test_all_supported_compression[zstd_15_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 15]
2025-11-21 14:05:49,177 - INFO - ya.test.1140674  - pytest_runtest_setup: ####################################################################################################
2025-11-21 14:05:49,177 - INFO - ya.test.1140674  - pytest_runtest_setup: Test setup
2025-11-21 14:05:49,180 - DEBUG - ya.test.1140674  - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-21 14:05:49,181 - DEBUG - ya.test.1140674  - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-21 14:05:49,182 - DEBUG - ya.test.1140674  - execute: Executing '['/home/runner/.ya/build/build_root/evw0/005d96/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-21 14:05:49,189 - DEBUG - ya.test.1140674  - execute: Command pid: 1142550
2025-11-21 14:05:50,259 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142550) rc: 0
2025-11-21 14:05:50,260 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142550) elapsed time (sec): 1.0685350894927979
2025-11-21 14:05:50,260 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142550) idrss: 0
2025-11-21 14:05:50,261 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142550) inblock: 0
2025-11-21 14:05:50,261 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142550) isrss: 0
2025-11-21 14:05:50,261 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142550) ixrss: 0
2025-11-21 14:05:50,261 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142550) majflt: 0
2025-11-21 14:05:50,262 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142550) maxrss: 485264
2025-11-21 14:05:50,262 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142550) minflt: 45604
2025-11-21 14:05:50,262 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142550) msgrcv: 0
2025-11-21 14:05:50,263 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142550) msgsnd: 0
2025-11-21 14:05:50,263 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142550) nivcsw: 137
2025-11-21 14:05:50,263 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142550) nsignals: 0
2025-11-21 14:05:50,263 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142550) nswap: 0
2025-11-21 14:05:50,264 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142550) nvcsw: 14
2025-11-21 14:05:50,264 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142550) oublock: 8
2025-11-21 14:05:50,264 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142550) stime: 0.317639
2025-11-21 14:05:50,264 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142550) utime: 0.5683239999999999
2025-11-21 14:05:50,265 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142550) wtime: 1.077
2025-11-21 14:05:50,265 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142550) 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-acwccf6kvy    Host information: 
        Linux ghrun-acwccf6kvy 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 14:05:50,266 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142550) errors:

2025-11-21 14:05:50,266 - INFO - __tests__.base.1140674  - _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-acwccf6kvy    Host information: 
        Linux ghrun-acwccf6kvy 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 14:05:50,400 - DEBUG - ya.test.1140674  - get_binary: Binary was found by /home/runner/.ya/build/build_root/evw0/005d96/ydb/apps/ydbd/ydbd
2025-11-21 14:05:50,402 - DEBUG - library.python.filelock.1140674  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/6668
2025-11-21 14:05:50,404 - DEBUG - ydb.tests.library.harness.kikimr_runner.1140674  - start: Working directory: /home/runner/.ya/build/build_root/evw0/005d96/r3tmp/kikimr_cluster_uw4sldjk
2025-11-21 14:05:50,451 - DEBUG - ya.test.1140674  - get_binary: Binary was found by /home/runner/.ya/build/build_root/evw0/005d96/ydb/apps/ydbd/ydbd
2025-11-21 14:05:50,452 - DEBUG - library.python.filelock.1140674  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/63750
2025-11-21 14:05:50,453 - DEBUG - library.python.filelock.1140674  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/4413
2025-11-21 14:05:50,453 - DEBUG - library.python.filelock.1140674  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/23710
2025-11-21 14:05:50,454 - DEBUG - library.python.filelock.1140674  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/11083
2025-11-21 14:05:50,455 - INFO - ydb.tests.library.harness.kikimr_runner.1140674  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/evw0/005d96/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_15_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.15/cluster/kikimr_configs"
2025-11-21 14:05:50,456 - INFO - ydb.tests.library.harness.kikimr_runner.1140674  - __make_run_command: Final command: /home/runner/.ya/build/build_root/evw0/005d96/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/evw0/005d96/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_15_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.15/cluster/node_1/logfile_kza3c3og.log --grpc-port=63750 --mon-port=4413 --ic-port=6668
2025-11-21 14:05:50,456 - DEBUG - ydb.tests.library.harness.kikimr_runner.1140674  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:63750/1, disk_size 68719476736
2025-11-21 14:05:50,457 - INFO - ydb.tests.library.harness.kikimr_runner.1140674  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/evw0/005d96/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_15_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.15/cluster/kikimr_configs"
2025-11-21 14:05:50,457 - INFO - ydb.tests.library.harness.kikimr_runner.1140674  - __make_run_command: Final command: /home/runner/.ya/build/build_root/evw0/005d96/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/evw0/005d96/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_15_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.15/cluster/node_1/logfile_kza3c3og.log --grpc-port=63750 --mon-port=4413 --ic-port=6668
2025-11-21 14:05:50,459 - DEBUG - ya.test.1140674  - execute: Executing '('/home/runner/.ya/build/build_root/evw0/005d96/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/evw0/005d96/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_15_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.15/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/evw0/005d96/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_15_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.15/cluster/node_1/logfile_kza3c3og.log', '--grpc-port=63750', '--mon-port=4413', '--ic-port=6668')' in '/home/runner/.ya/build/build_root/evw0/005d96/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_15_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.15/cluster/node_1' (no wait)
2025-11-21 14:05:50,463 - DEBUG - ya.test.1140674  - execute: Command pid: 1142894
2025-11-21 14:05:50,464 - INFO - ydb.tests.library.harness.kikimr_runner.1140674  - start: Started node localhost:63750/1
2025-11-21 14:05:50,466 - DEBUG - ya.test.1140674  - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-21 14:05:50,467 - DEBUG - ya.test.1140674  - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-21 14:05:50,468 - DEBUG - ya.test.1140674  - execute: Executing '['/home/runner/.ya/build/build_root/evw0/005d96/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-21 14:05:50,483 - DEBUG - ya.test.1140674  - execute: Command pid: 1142895
2025-11-21 14:05:51,791 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142895) rc: 0
2025-11-21 14:05:51,792 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142895) elapsed time (sec): 1.307082176208496
2025-11-21 14:05:51,793 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142895) idrss: 0
2025-11-21 14:05:51,793 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142895) inblock: 0
2025-11-21 14:05:51,793 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142895) isrss: 0
2025-11-21 14:05:51,794 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142895) ixrss: 0
2025-11-21 14:05:51,794 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142895) majflt: 0
2025-11-21 14:05:51,795 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142895) maxrss: 486604
2025-11-21 14:05:51,795 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142895) minflt: 45506
2025-11-21 14:05:51,795 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142895) msgrcv: 0
2025-11-21 14:05:51,796 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142895) msgsnd: 0
2025-11-21 14:05:51,796 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142895) nivcsw: 220
2025-11-21 14:05:51,796 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142895) nsignals: 0
2025-11-21 14:05:51,797 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142895) nswap: 0
2025-11-21 14:05:51,797 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142895) nvcsw: 14
2025-11-21 14:05:51,797 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142895) oublock: 8
2025-11-21 14:05:51,798 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142895) stime: 0.221572
2025-11-21 14:05:51,798 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142895) utime: 0.545145
2025-11-21 14:05:51,798 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142895) wtime: 1.323
2025-11-21 14:05:51,800 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142895) 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-acwccf6kvy    Host information: 
        Linux ghrun-acwccf6kvy 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 14:05:51,800 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1142895) errors:

2025-11-21 14:05:51,801 - INFO - ydb.tests.library.harness.kikimr_runner.1140674  - 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-acwccf6kvy    Host information: 
        Linux ghrun-acwccf6kvy 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64
2025-11-21 14:05:57,899 - DEBUG - ya.test.1140674  - get_binary: Binary was found by /home/runner/.ya/build/build_root/evw0/005d96/ydb/apps/ydbd/ydbd
2025-11-21 14:05:57,900 - DEBUG - ydb.tests.library.harness.kikimr_runner.1140674  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/evw0/005d96/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:63750', '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: 6668\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-21 14:05:57,901 - DEBUG - ya.test.1140674  - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-21 14:05:57,902 - DEBUG - ya.test.1140674  - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-21 14:05:57,902 - DEBUG - ya.test.1140674  - execute: Executing '['/home/runner/.ya/build/build_root/evw0/005d96/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:63750', '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: 6668\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-21 14:05:57,921 - DEBUG - ya.test.1140674  - execute: Command pid: 1145611
2025-11-21 14:05:59,587 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1145611) rc: 0
2025-11-21 14:05:59,587 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1145611) elapsed time (sec): 1.6606192588806152
2025-11-21 14:05:59,588 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1145611) idrss: 0
2025-11-21 14:05:59,588 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1145611) inblock: 0
2025-11-21 14:05:59,588 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1145611) isrss: 0
2025-11-21 14:05:59,589 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1145611) ixrss: 0
2025-11-21 14:05:59,589 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1145611) majflt: 0
2025-11-21 14:05:59,589 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1145611) maxrss: 596924
2025-11-21 14:05:59,590 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1145611) minflt: 52055
2025-11-21 14:05:59,590 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1145611) msgrcv: 0
2025-11-21 14:05:59,590 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1145611) msgsnd: 0
2025-11-21 14:05:59,590 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1145611) nivcsw: 245
2025-11-21 14:05:59,595 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1145611) nsignals: 0
2025-11-21 14:05:59,596 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1145611) nswap: 0
2025-11-21 14:05:59,596 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1145611) nvcsw: 553
2025-11-21 14:05:59,596 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1145611) oublock: 8
2025-11-21 14:05:59,597 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1145611) stime: 0.334144
2025-11-21 14:05:59,597 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1145611) utime: 0.599976
2025-11-21 14:05:59,597 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1145611) wtime: 1.679
2025-11-21 14:05:59,598 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1145611) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-21 14:05:59,598 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1145611) errors:

2025-11-21 14:05:59,608 - DEBUG - ya.test.1140674  - get_binary: Binary was found by /home/runner/.ya/build/build_root/evw0/005d96/ydb/apps/ydbd/ydbd
2025-11-21 14:05:59,609 - DEBUG - ydb.tests.library.harness.kikimr_runner.1140674  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/evw0/005d96/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:63750', '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 14:05:59,610 - DEBUG - ya.test.1140674  - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-21 14:05:59,620 - DEBUG - ya.test.1140674  - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-21 14:05:59,621 - DEBUG - ya.test.1140674  - execute: Executing '['/home/runner/.ya/build/build_root/evw0/005d96/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:63750', '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 14:05:59,631 - DEBUG - ya.test.1140674  - execute: Command pid: 1146006
2025-11-21 14:06:01,479 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1146006) rc: 0
2025-11-21 14:06:01,479 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1146006) elapsed time (sec): 1.8230297565460205
2025-11-21 14:06:01,480 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1146006) idrss: 0
2025-11-21 14:06:01,480 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1146006) inblock: 0
2025-11-21 14:06:01,480 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1146006) isrss: 0
2025-11-21 14:06:01,481 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1146006) ixrss: 0
2025-11-21 14:06:01,481 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1146006) majflt: 0
2025-11-21 14:06:01,481 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1146006) maxrss: 597488
2025-11-21 14:06:01,481 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1146006) minflt: 52036
2025-11-21 14:06:01,482 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1146006) msgrcv: 0
2025-11-21 14:06:01,482 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1146006) msgsnd: 0
2025-11-21 14:06:01,482 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1146006) nivcsw: 201
2025-11-21 14:06:01,487 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1146006) nsignals: 0
2025-11-21 14:06:01,487 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1146006) nswap: 0
2025-11-21 14:06:01,488 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1146006) nvcsw: 554
2025-11-21 14:06:01,488 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1146006) oublock: 8
2025-11-21 14:06:01,488 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1146006) stime: 0.27302299999999996
2025-11-21 14:06:01,488 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1146006) utime: 0.644697
2025-11-21 14:06:01,489 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1146006) wtime: 1.834
2025-11-21 14:06:01,489 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1146006) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-11-21 14:06:01,489 - DEBUG - ya.test.1140674  - _save_outputs: Command (pid 1146006) errors:

2025-11-21 14:06:01,490 - INFO - ydb.tests.library.harness.kikimr_runner.1140674  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-21 14:06:01,696 - INFO - ydb.tests.library.harness.kikimr_runner.1140674  - __run: Cluster started and initialized
2025-11-21 14:06:01,756 - DEBUG - ydb.connection.1140674  - 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 14:06:01,771 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1140674  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-21 14:06:01,772 - DEBUG - ydb.connection.1140674  - 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 14:06:01,857 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1140674  - context_resolve: Resolving endpoints for database /Root
2025-11-21 14:06:01,858 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ListEndpoints, bfb2a55f-4dbf-4a08-a75d-8632fdb752d5, localhost:63750): creating call state
2025-11-21 14:06:01,859 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ListEndpoints, bfb2a55f-4dbf-4a08-a75d-8632fdb752d5, localhost:63750): request = { database: "/Root" }
2025-11-21 14:06:01,869 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ListEndpoints, bfb2a55f-4dbf-4a08-a75d-8632fdb752d5, localhost:63750): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-acwccf6kvy.auto.internal" port: 63750 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 14:06:01,870 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1140674  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-acwccf6kvy.auto.internal:63750, location 1, ssl: False>]>
2025-11-21 14:06:01,875 - DEBUG - ydb.connection.1140674  - 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 14:06:01,929 - DEBUG - ydb.connection.1140674  - close: Closing channel for endpoint localhost:63750
2025-11-21 14:06:01,931 - DEBUG - ydb.query.pool.1140674  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-21 14:06:01,933 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(CreateSession, 5a2a2909-72b8-4049-ae51-6794aad29159, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:01,933 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(CreateSession, 5a2a2909-72b8-4049-ae51-6794aad29159, ghrun-acwccf6kvy.auto.internal:63750): request = {  }
2025-11-21 14:06:01,948 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(CreateSession, 5a2a2909-72b8-4049-ae51-6794aad29159, ghrun-acwccf6kvy.auto.internal:63750): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" node_id: 1 }
2025-11-21 14:06:01,949 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(AttachSession, 8bd92908-216b-4b21-b4b9-fe6000986a1c, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:01,950 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(AttachSession, 8bd92908-216b-4b21-b4b9-fe6000986a1c, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" }
2025-11-21 14:06:01,975 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(AttachSession, 8bd92908-216b-4b21-b4b9-fe6000986a1c, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:02,003 - DEBUG - ydb.query.pool.1140674  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:02,004 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 54c41798-6b58-41ff-82f8-dd83f5966f1f, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:02,005 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 54c41798-6b58-41ff-82f8-dd83f5966f1f, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:02,010 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 54c41798-6b58-41ff-82f8-dd83f5966f1f, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:07,075 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:07,076 - INFO - __tests__.alter_compression.1140674  - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-11-21 14:06:07,076 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:07,077 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 5047aa50-a147-44f4-a502-1cebf4fdb2f3, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:07,078 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 5047aa50-a147-44f4-a502-1cebf4fdb2f3, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:07,086 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 5047aa50-a147-44f4-a502-1cebf4fdb2f3, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:08,383 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:08,384 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:08,384 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 551efdc2-1bd1-4e55-bb3f-e3466600ff65, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:08,385 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 551efdc2-1bd1-4e55-bb3f-e3466600ff65, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:08,388 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 551efdc2-1bd1-4e55-bb3f-e3466600ff65, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:10,287 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:10,288 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:10,289 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 8fa44b91-23d0-4f9e-8b3c-86ccc6ff7d5c, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:10,290 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 8fa44b91-23d0-4f9e-8b3c-86ccc6ff7d5c, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:10,302 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 8fa44b91-23d0-4f9e-8b3c-86ccc6ff7d5c, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:12,677 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:12,678 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:12,679 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 2ef537e4-6bc4-4984-a4ac-01a57eca86ad, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:12,680 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 2ef537e4-6bc4-4984-a4ac-01a57eca86ad, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:12,681 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 2ef537e4-6bc4-4984-a4ac-01a57eca86ad, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:15,791 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:15,792 - INFO - __tests__.alter_compression.1140674  - 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 14:06:15,793 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:15,794 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 027238b2-91c1-418f-8ee3-fb5dd3b382f3, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:15,795 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 027238b2-91c1-418f-8ee3-fb5dd3b382f3, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:15,796 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 027238b2-91c1-418f-8ee3-fb5dd3b382f3, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:17,463 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:17,464 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:17,464 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, fe39adf5-88f5-4dab-9622-fedcd0d1b9bb, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:17,465 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, fe39adf5-88f5-4dab-9622-fedcd0d1b9bb, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:17,479 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, fe39adf5-88f5-4dab-9622-fedcd0d1b9bb, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:17,871 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:17,872 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:17,873 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 8426013b-2899-4471-9c4b-bbdfdbf5484f, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:17,874 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 8426013b-2899-4471-9c4b-bbdfdbf5484f, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:17,891 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 8426013b-2899-4471-9c4b-bbdfdbf5484f, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:18,596 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:18,597 - INFO - __tests__.alter_compression.1140674  - 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 14:06:18,598 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:18,599 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 72f4953c-0eda-4283-b3d7-ce3206e1b7b7, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:18,600 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 72f4953c-0eda-4283-b3d7-ce3206e1b7b7, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:18,606 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 72f4953c-0eda-4283-b3d7-ce3206e1b7b7, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:19,912 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:19,913 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:19,914 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 0440370b-76d3-41aa-a6f8-8bde9b94981d, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:19,915 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 0440370b-76d3-41aa-a6f8-8bde9b94981d, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:19,916 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 0440370b-76d3-41aa-a6f8-8bde9b94981d, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:20,518 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:20,518 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:20,519 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 5703495a-46e1-4c6a-837c-3f1a343adebc, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:20,520 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 5703495a-46e1-4c6a-837c-3f1a343adebc, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:20,527 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 5703495a-46e1-4c6a-837c-3f1a343adebc, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:21,695 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:21,696 - INFO - __tests__.alter_compression.1140674  - 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 14:06:21,696 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:21,697 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 554411ea-a17b-441c-b9de-b9494f485b36, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:21,698 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 554411ea-a17b-441c-b9de-b9494f485b36, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:21,700 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 554411ea-a17b-441c-b9de-b9494f485b36, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:22,888 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:22,889 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:22,889 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, efd182c5-0c38-4b4c-af81-b7ec49d970fc, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:22,890 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, efd182c5-0c38-4b4c-af81-b7ec49d970fc, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:22,892 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, efd182c5-0c38-4b4c-af81-b7ec49d970fc, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:23,306 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:23,307 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:23,308 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 9da9a773-87a1-4292-81ca-696cdc4ad9d1, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:23,308 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 9da9a773-87a1-4292-81ca-696cdc4ad9d1, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:23,315 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 9da9a773-87a1-4292-81ca-696cdc4ad9d1, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:25,152 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:25,153 - INFO - __tests__.alter_compression.1140674  - 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 14:06:25,153 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:25,154 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 55b03eb5-0cf8-41d7-b7d6-4ef32251c77b, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:25,155 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 55b03eb5-0cf8-41d7-b7d6-4ef32251c77b, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:25,160 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 55b03eb5-0cf8-41d7-b7d6-4ef32251c77b, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:26,945 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:26,945 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:26,946 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 3b59f406-e2c6-44e5-8e0b-2190766d7738, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:26,947 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 3b59f406-e2c6-44e5-8e0b-2190766d7738, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:26,948 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 3b59f406-e2c6-44e5-8e0b-2190766d7738, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:27,568 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:27,569 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:27,569 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, c1321db9-0975-4503-9294-65372d26a73e, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:27,570 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, c1321db9-0975-4503-9294-65372d26a73e, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:27,573 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, c1321db9-0975-4503-9294-65372d26a73e, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:29,144 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:29,145 - INFO - __tests__.alter_compression.1140674  - 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 14:06:29,146 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:29,146 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 879554e8-8c21-4874-907b-6c412dcc5388, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:29,147 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 879554e8-8c21-4874-907b-6c412dcc5388, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:29,149 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 879554e8-8c21-4874-907b-6c412dcc5388, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:30,580 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:30,581 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:30,582 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 7a48f1a7-0d44-4510-980d-43142c90bfd1, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:30,583 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 7a48f1a7-0d44-4510-980d-43142c90bfd1, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:30,585 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 7a48f1a7-0d44-4510-980d-43142c90bfd1, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:31,318 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:31,319 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:31,320 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 037e6e1b-c603-49bc-8dc9-be2da6577d50, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:31,321 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 037e6e1b-c603-49bc-8dc9-be2da6577d50, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:31,330 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 037e6e1b-c603-49bc-8dc9-be2da6577d50, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:32,528 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:32,529 - INFO - __tests__.alter_compression.1140674  - 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 14:06:32,530 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:32,530 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 8332fe61-55e4-45f8-bb49-73289f93dc24, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:32,531 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 8332fe61-55e4-45f8-bb49-73289f93dc24, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:32,548 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 8332fe61-55e4-45f8-bb49-73289f93dc24, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:34,342 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:34,343 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:34,344 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 7340f8fd-e695-4ab2-8c21-a53bc691e058, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:34,344 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 7340f8fd-e695-4ab2-8c21-a53bc691e058, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:34,346 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 7340f8fd-e695-4ab2-8c21-a53bc691e058, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:35,208 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:35,209 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:35,210 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, c08c2622-4a58-4980-9f8c-9662d754fe6f, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:35,211 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, c08c2622-4a58-4980-9f8c-9662d754fe6f, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:35,212 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, c08c2622-4a58-4980-9f8c-9662d754fe6f, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:38,275 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:38,276 - INFO - __tests__.alter_compression.1140674  - 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 14:06:38,276 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:38,277 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 55a27ded-47c7-4782-a6c0-f7fd4a91a6ef, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:38,278 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 55a27ded-47c7-4782-a6c0-f7fd4a91a6ef, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:38,294 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 55a27ded-47c7-4782-a6c0-f7fd4a91a6ef, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:41,295 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:41,296 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:41,296 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, cdf52f59-9c91-49c6-b58e-5216c4186873, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:41,297 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, cdf52f59-9c91-49c6-b58e-5216c4186873, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:41,323 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, cdf52f59-9c91-49c6-b58e-5216c4186873, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:42,056 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:42,056 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:42,057 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 06c31e3c-ccb0-4c86-a218-8841efcb44e4, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:42,058 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 06c31e3c-ccb0-4c86-a218-8841efcb44e4, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:42,073 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 06c31e3c-ccb0-4c86-a218-8841efcb44e4, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:44,548 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:44,549 - INFO - __tests__.alter_compression.1140674  - 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 14:06:44,550 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:44,551 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 5085cb6e-80b0-4e61-aec0-1024c2be9785, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:44,552 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 5085cb6e-80b0-4e61-aec0-1024c2be9785, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:44,553 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 5085cb6e-80b0-4e61-aec0-1024c2be9785, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:47,323 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:47,324 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:47,325 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 8605d25b-7be3-4a16-a66a-075dfe44d2e7, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:47,326 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 8605d25b-7be3-4a16-a66a-075dfe44d2e7, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:47,328 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 8605d25b-7be3-4a16-a66a-075dfe44d2e7, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:48,269 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:48,270 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:48,271 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, cbf666eb-3f79-49bb-b909-b24b1c2b9450, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:48,272 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, cbf666eb-3f79-49bb-b909-b24b1c2b9450, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:48,275 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, cbf666eb-3f79-49bb-b909-b24b1c2b9450, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:51,110 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:51,111 - INFO - __tests__.alter_compression.1140674  - 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 14:06:51,111 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:51,117 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, a29f9fe7-8a76-425a-ba0e-ccf48861cb31, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:51,118 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, a29f9fe7-8a76-425a-ba0e-ccf48861cb31, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:51,127 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, a29f9fe7-8a76-425a-ba0e-ccf48861cb31, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:53,802 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:53,803 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:53,804 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 95014a1a-f0c1-4be6-9952-d450f36b7a73, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:53,805 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 95014a1a-f0c1-4be6-9952-d450f36b7a73, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:53,807 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 95014a1a-f0c1-4be6-9952-d450f36b7a73, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:56,022 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:56,023 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:56,024 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, f942802c-f960-44f8-b420-d036683eaad3, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:56,028 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, f942802c-f960-44f8-b420-d036683eaad3, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:56,029 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, f942802c-f960-44f8-b420-d036683eaad3, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:06:58,623 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:58,624 - INFO - __tests__.alter_compression.1140674  - 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 14:06:58,624 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:06:58,625 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, d96cd122-3ef1-4361-ade1-29b845fbfeaf, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:06:58,626 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, d96cd122-3ef1-4361-ade1-29b845fbfeaf, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:06:58,646 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, d96cd122-3ef1-4361-ade1-29b845fbfeaf, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:02,677 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:07:02,677 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:07:02,678 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 4ea30b95-ed36-49da-9c0c-b76bcafadb2c, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:07:02,682 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 4ea30b95-ed36-49da-9c0c-b76bcafadb2c, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:07:02,683 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 4ea30b95-ed36-49da-9c0c-b76bcafadb2c, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:03,478 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:07:03,479 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:07:03,480 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 613f7d14-9efb-432d-8ef1-d96528f62800, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:07:03,481 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 613f7d14-9efb-432d-8ef1-d96528f62800, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:07:03,482 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 613f7d14-9efb-432d-8ef1-d96528f62800, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:04,408 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:07:04,408 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:07:04,409 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, e4127b83-df62-4687-919e-cc9c118bff79, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:07:04,410 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, e4127b83-df62-4687-919e-cc9c118bff79, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:07:04,442 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, e4127b83-df62-4687-919e-cc9c118bff79, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:15,918 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:07:25,963 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:07:25,964 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 78f6168a-d2d4-41db-b08c-cb74efdb65f6, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:07:25,965 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 78f6168a-d2d4-41db-b08c-cb74efdb65f6, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:07:25,966 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 78f6168a-d2d4-41db-b08c-cb74efdb65f6, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:31,288 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:07:41,403 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:07:41,404 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, bde9bd1e-105a-4569-9520-a6d566b21bc0, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:07:41,408 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, bde9bd1e-105a-4569-9520-a6d566b21bc0, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:07:41,410 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, bde9bd1e-105a-4569-9520-a6d566b21bc0, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:43,386 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:07:43,390 - INFO - root.1140674  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8009216)
2025-11-21 14:07:43,391 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:07:43,391 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 82e4a290-0594-4473-a1df-59779bc4c2aa, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:07:43,392 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 82e4a290-0594-4473-a1df-59779bc4c2aa, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:07:43,394 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 82e4a290-0594-4473-a1df-59779bc4c2aa, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:44,803 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1140674  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-21 14:07:44,804 - DEBUG - ydb.connection.1140674  - 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 14:07:44,856 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1140674  - context_resolve: Resolving endpoints for database /Root
2025-11-21 14:07:44,896 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ListEndpoints, f58e0ba6-ca35-4687-bcea-d0fb3d08b8b1, localhost:63750): creating call state
2025-11-21 14:07:44,897 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ListEndpoints, f58e0ba6-ca35-4687-bcea-d0fb3d08b8b1, localhost:63750): request = { database: "/Root" }
2025-11-21 14:07:45,060 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ListEndpoints, f58e0ba6-ca35-4687-bcea-d0fb3d08b8b1, localhost:63750): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-acwccf6kvy.auto.internal" port: 63750 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 14:07:45,061 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1140674  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-acwccf6kvy.auto.internal:63750, location 1, ssl: False>]>
2025-11-21 14:07:45,062 - DEBUG - ydb.connection.1140674  - close: Closing channel for endpoint localhost:63750
2025-11-21 14:07:45,155 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:07:55,162 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:07:55,163 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, d403289c-3d1e-4636-8a80-789db085c40f, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:07:55,164 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, d403289c-3d1e-4636-8a80-789db085c40f, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:07:55,165 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, d403289c-3d1e-4636-8a80-789db085c40f, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:56,700 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:07:56,704 - INFO - root.1140674  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8009216)
2025-11-21 14:07:56,704 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:07:56,705 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, b8c86044-dcb0-400e-9029-45674872f134, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:07:56,706 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, b8c86044-dcb0-400e-9029-45674872f134, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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 14:07:56,712 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, b8c86044-dcb0-400e-9029-45674872f134, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:07:57,384 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:07:57,387 - INFO - ya.test.1140674  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_15_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 15])
2025-11-21 14:07:57,388 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:07:57,389 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 398312e0-bf1c-4b69-bcf3-cd32fa148691, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:07:57,390 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 398312e0-bf1c-4b69-bcf3-cd32fa148691, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_15_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 15)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:07:57,395 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 398312e0-bf1c-4b69-bcf3-cd32fa148691, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:05,087 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:05,088 - INFO - __tests__.alter_compression.1140674  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_15_compression created
2025-11-21 14:08:05,088 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:05,096 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 4c5de433-c2f0-4e41-995c-8a6a9ed8ea55, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:08:05,097 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 4c5de433-c2f0-4e41-995c-8a6a9ed8ea55, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_15_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:05,099 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 4c5de433-c2f0-4e41-995c-8a6a9ed8ea55, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:06,184 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:06,187 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:06,188 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 27ba0923-1e26-42e4-8880-3b26a1c0f109, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:08:06,189 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 27ba0923-1e26-42e4-8880-3b26a1c0f109, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:06,203 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 27ba0923-1e26-42e4-8880-3b26a1c0f109, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:15,105 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:15,106 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:15,107 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, e46aeda2-9098-47c6-84f1-abbac45ec58f, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:08:15,108 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, e46aeda2-9098-47c6-84f1-abbac45ec58f, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:15,122 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, e46aeda2-9098-47c6-84f1-abbac45ec58f, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:17,088 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:17,089 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:17,090 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 43168441-b641-40b8-8aab-df9d9839d330, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:08:17,091 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 43168441-b641-40b8-8aab-df9d9839d330, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:17,107 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 43168441-b641-40b8-8aab-df9d9839d330, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:21,349 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:21,350 - INFO - __tests__.alter_compression.1140674  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318544, 'BlobCount': 128}}
2025-11-21 14:08:21,351 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:21,352 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 4104c364-26f9-4552-9a29-270c4e7f8668, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:08:21,352 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 4104c364-26f9-4552-9a29-270c4e7f8668, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:21,361 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 4104c364-26f9-4552-9a29-270c4e7f8668, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:28,418 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:28,419 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:28,419 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 1d49204c-b0e9-44eb-8349-922080cd0894, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:08:28,420 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 1d49204c-b0e9-44eb-8349-922080cd0894, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:28,424 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 1d49204c-b0e9-44eb-8349-922080cd0894, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:29,028 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:29,029 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:29,030 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 37ceb2cb-3726-418b-8ed7-f0918efcec73, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:08:29,032 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 37ceb2cb-3726-418b-8ed7-f0918efcec73, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:29,033 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 37ceb2cb-3726-418b-8ed7-f0918efcec73, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:29,779 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:29,780 - INFO - __tests__.alter_compression.1140674  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 638064, 'BlobCount': 256}}
2025-11-21 14:08:29,780 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:29,781 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 96fbd09c-8873-45cd-ab5b-c11bc336896b, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:08:29,782 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 96fbd09c-8873-45cd-ab5b-c11bc336896b, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:29,789 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 96fbd09c-8873-45cd-ab5b-c11bc336896b, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:36,504 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:36,505 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:36,506 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 8f5078e0-1389-4914-9480-b6655c3d486f, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:08:36,507 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 8f5078e0-1389-4914-9480-b6655c3d486f, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:36,508 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 8f5078e0-1389-4914-9480-b6655c3d486f, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:37,492 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:37,492 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:37,493 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, cc81273a-d63a-4cbd-8c5d-7e4b723b8a32, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:08:37,494 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, cc81273a-d63a-4cbd-8c5d-7e4b723b8a32, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:37,495 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, cc81273a-d63a-4cbd-8c5d-7e4b723b8a32, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:38,383 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:38,384 - INFO - __tests__.alter_compression.1140674  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 957088, 'BlobCount': 384}}
2025-11-21 14:08:38,384 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:38,385 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, a646765d-94fa-4b0e-9c13-1582d857964f, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:08:38,386 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, a646765d-94fa-4b0e-9c13-1582d857964f, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:38,387 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, a646765d-94fa-4b0e-9c13-1582d857964f, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:43,809 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:43,809 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:43,810 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 540298a8-c98c-4bd0-937c-dc6933bef248, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:08:43,811 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 540298a8-c98c-4bd0-937c-dc6933bef248, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:43,812 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 540298a8-c98c-4bd0-937c-dc6933bef248, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:44,886 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:44,887 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:44,887 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 26428f6b-fb89-4542-b26d-12c92010545e, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:08:44,888 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 26428f6b-fb89-4542-b26d-12c92010545e, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:44,890 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 26428f6b-fb89-4542-b26d-12c92010545e, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:46,075 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:46,075 - INFO - __tests__.alter_compression.1140674  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1276560, 'BlobCount': 512}}
2025-11-21 14:08:46,076 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:46,077 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, d685aa92-aa59-41eb-bdd3-c0e87ec98c7c, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:08:46,077 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, d685aa92-aa59-41eb-bdd3-c0e87ec98c7c, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:46,090 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, d685aa92-aa59-41eb-bdd3-c0e87ec98c7c, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:52,843 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:52,844 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:52,845 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, ec2a92e7-6a0e-4ecb-93d7-f7994e68849e, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:08:52,846 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, ec2a92e7-6a0e-4ecb-93d7-f7994e68849e, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:52,847 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, ec2a92e7-6a0e-4ecb-93d7-f7994e68849e, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:53,483 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:53,484 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:53,485 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 2c8517aa-1592-4431-a4f1-c03e25e8e8fb, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:08:53,486 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 2c8517aa-1592-4431-a4f1-c03e25e8e8fb, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:53,487 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 2c8517aa-1592-4431-a4f1-c03e25e8e8fb, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:08:55,009 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:55,010 - INFO - __tests__.alter_compression.1140674  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1595584, 'BlobCount': 640}}
2025-11-21 14:08:55,011 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:08:55,011 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 656002d9-25c1-4907-a4d9-4b7f1a05d90a, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:08:55,013 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 656002d9-25c1-4907-a4d9-4b7f1a05d90a, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:08:55,023 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 656002d9-25c1-4907-a4d9-4b7f1a05d90a, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:01,324 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:01,325 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:01,325 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, a63e35df-c0e6-45e0-af24-f767699ec30b, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:09:01,326 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, a63e35df-c0e6-45e0-af24-f767699ec30b, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:01,327 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, a63e35df-c0e6-45e0-af24-f767699ec30b, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:01,875 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:01,876 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:01,877 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, d9c813e8-82cd-4d89-90ef-d37289ed7f29, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:09:01,878 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, d9c813e8-82cd-4d89-90ef-d37289ed7f29, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:01,880 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, d9c813e8-82cd-4d89-90ef-d37289ed7f29, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:03,136 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:03,137 - INFO - __tests__.alter_compression.1140674  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1914960, 'BlobCount': 768}}
2025-11-21 14:09:03,137 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:03,138 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 8b062475-5794-4060-a280-44737ca07fd5, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:09:03,139 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 8b062475-5794-4060-a280-44737ca07fd5, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:03,141 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 8b062475-5794-4060-a280-44737ca07fd5, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:10,808 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:10,809 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:10,810 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 0e5531fd-bade-4eb4-81b6-03d5ae87dedd, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:09:10,811 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 0e5531fd-bade-4eb4-81b6-03d5ae87dedd, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:10,812 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 0e5531fd-bade-4eb4-81b6-03d5ae87dedd, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:11,293 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:11,294 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:11,294 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 4ab816d3-db60-411f-a619-4314be38ec80, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:09:11,296 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 4ab816d3-db60-411f-a619-4314be38ec80, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:11,301 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 4ab816d3-db60-411f-a619-4314be38ec80, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:12,201 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:12,202 - INFO - __tests__.alter_compression.1140674  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2234080, 'BlobCount': 896}}
2025-11-21 14:09:12,202 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:12,203 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, d9c29934-120d-4efd-b615-f605d1a9bb06, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:09:12,204 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, d9c29934-120d-4efd-b615-f605d1a9bb06, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:12,211 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, d9c29934-120d-4efd-b615-f605d1a9bb06, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:16,155 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:16,156 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:16,157 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 569003ba-422c-41f1-aa9e-0f51b856f2e9, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:09:16,158 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 569003ba-422c-41f1-aa9e-0f51b856f2e9, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:16,161 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 569003ba-422c-41f1-aa9e-0f51b856f2e9, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:17,050 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:17,051 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:17,052 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 10ae61e4-0568-4eb8-b5e0-3491dfdff5f4, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:09:17,053 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 10ae61e4-0568-4eb8-b5e0-3491dfdff5f4, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:17,064 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 10ae61e4-0568-4eb8-b5e0-3491dfdff5f4, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:18,632 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:18,632 - INFO - __tests__.alter_compression.1140674  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2553696, 'BlobCount': 1024}}
2025-11-21 14:09:18,633 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:18,634 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 73ef39ec-66f6-4ec3-aa23-b330e2085217, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:09:18,639 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 73ef39ec-66f6-4ec3-aa23-b330e2085217, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:18,641 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 73ef39ec-66f6-4ec3-aa23-b330e2085217, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:23,075 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:23,076 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:23,076 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, a4df72c2-9b65-4ee8-9993-3b8ca94fdf56, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:09:23,077 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, a4df72c2-9b65-4ee8-9993-3b8ca94fdf56, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:23,078 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, a4df72c2-9b65-4ee8-9993-3b8ca94fdf56, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:23,805 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:23,806 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:23,807 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 03b239a2-3442-4c2b-87a9-ad93023677d5, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:09:23,808 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 03b239a2-3442-4c2b-87a9-ad93023677d5, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:23,812 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 03b239a2-3442-4c2b-87a9-ad93023677d5, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:25,317 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:25,318 - INFO - __tests__.alter_compression.1140674  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2872720, 'BlobCount': 1152}}
2025-11-21 14:09:25,319 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:25,320 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 7d621cf3-5255-4ff5-99cb-18cf903db23d, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:09:25,321 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 7d621cf3-5255-4ff5-99cb-18cf903db23d, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:25,328 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 7d621cf3-5255-4ff5-99cb-18cf903db23d, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:29,118 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:29,118 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:29,119 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 5145626a-9924-43b5-8ff2-234b331b02fb, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:09:29,120 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 5145626a-9924-43b5-8ff2-234b331b02fb, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:29,121 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 5145626a-9924-43b5-8ff2-234b331b02fb, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:29,394 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:29,395 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:29,396 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, edb4ff74-da3b-474d-a48e-8fced1a2cc76, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:09:29,396 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, edb4ff74-da3b-474d-a48e-8fced1a2cc76, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:29,398 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, edb4ff74-da3b-474d-a48e-8fced1a2cc76, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:30,079 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:30,080 - INFO - __tests__.alter_compression.1140674  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3192432, 'BlobCount': 1280}}
2025-11-21 14:09:30,080 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:30,081 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 2f2ede65-2aba-441a-854b-c8166ed1c1fd, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:09:30,081 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 2f2ede65-2aba-441a-854b-c8166ed1c1fd, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_15_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:30,083 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 2f2ede65-2aba-441a-854b-c8166ed1c1fd, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:31,812 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:31,813 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:31,814 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 8e8367da-8504-48dc-aa15-8203fdc79e13, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:09:31,815 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 8e8367da-8504-48dc-aa15-8203fdc79e13, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:31,822 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 8e8367da-8504-48dc-aa15-8203fdc79e13, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:32,427 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:32,428 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:32,429 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 4e86e143-1f45-4d32-b42f-1e900726de7f, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:09:32,430 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 4e86e143-1f45-4d32-b42f-1e900726de7f, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:32,432 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 4e86e143-1f45-4d32-b42f-1e900726de7f, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:33,011 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:33,012 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:33,013 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, f67fb285-1017-4420-9d1b-a2740d3b831c, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:09:33,014 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, f67fb285-1017-4420-9d1b-a2740d3b831c, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:33,018 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, f67fb285-1017-4420-9d1b-a2740d3b831c, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:41,888 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1140674  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-21 14:09:41,888 - DEBUG - ydb.connection.1140674  - 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 14:09:41,954 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1140674  - context_resolve: Resolving endpoints for database /Root
2025-11-21 14:09:41,955 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ListEndpoints, 76912305-e014-4abe-bea5-af6965491948, localhost:63750): creating call state
2025-11-21 14:09:41,955 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ListEndpoints, 76912305-e014-4abe-bea5-af6965491948, localhost:63750): request = { database: "/Root" }
2025-11-21 14:09:41,964 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ListEndpoints, 76912305-e014-4abe-bea5-af6965491948, localhost:63750): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-acwccf6kvy.auto.internal" port: 63750 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 14:09:41,965 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1140674  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-acwccf6kvy.auto.internal:63750, location 1, ssl: False>]>
2025-11-21 14:09:41,966 - DEBUG - ydb.connection.1140674  - close: Closing channel for endpoint localhost:63750
2025-11-21 14:09:42,286 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:52,404 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:52,405 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, d327bf6f-7d23-4ce1-8137-034ef0b20aa6, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:09:52,406 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, d327bf6f-7d23-4ce1-8137-034ef0b20aa6, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:52,411 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, d327bf6f-7d23-4ce1-8137-034ef0b20aa6, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:09:59,684 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:59,730 - INFO - root.1140674  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_15_compression`, volumes `value` (8000000, 1596216)
2025-11-21 14:09:59,730 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:09:59,731 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, d5e0f070-797a-4dd4-b965-dbd5c847e3b2, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:09:59,733 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, d5e0f070-797a-4dd4-b965-dbd5c847e3b2, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" 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_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:09:59,734 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, d5e0f070-797a-4dd4-b965-dbd5c847e3b2, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:10:00,169 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:10:00,169 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:10:00,170 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 4da13ec4-116d-4b60-b7e6-6299ee10d667, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:10:00,171 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 4da13ec4-116d-4b60-b7e6-6299ee10d667, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:10:00,178 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 4da13ec4-116d-4b60-b7e6-6299ee10d667, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:10:09,085 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:10:19,127 - DEBUG - ydb.query.pool.1140674  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:10:19,128 - DEBUG - ydb.connection.1140674  - _prepare_call: RpcState(ExecuteQuery, 1f0c458d-74d2-449c-b1f6-e347e3ad40e1, ghrun-acwccf6kvy.auto.internal:63750): creating call state
2025-11-21 14:10:19,129 - DEBUG - ydb.connection.1140674  - _log_request: RpcState(ExecuteQuery, 1f0c458d-74d2-449c-b1f6-e347e3ad40e1, ghrun-acwccf6kvy.auto.internal:63750): request = { session_id: "ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-21 14:10:19,130 - DEBUG - ydb.connection.1140674  - _log_response: RpcState(ExecuteQuery, 1f0c458d-74d2-449c-b1f6-e347e3ad40e1, ghrun-acwccf6kvy.auto.internal:63750): response = { <_MultiThreadedRendezvous object> }
2025-11-21 14:10:24,076 - DEBUG - ydb.query.pool.1140674  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODZhMWRhNGQtYzAzNjdjNTgtOTY5ZWJhMzUtYTY1NjkzNjk=
2025-11-21 14:10:24,091 - INFO - root.1140674  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_15_compression`, volumes `value` (8000000, 1686408)
2025-11-21 14:10:24,092 - INFO - root.1140674  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_15_compression` 8009216 / 1686408: 4.749275382944104
2025-11-21 14:10:24,130 - INFO - ya.test.1140674  - pytest_runtest_teardown: Test teardown
