2025-11-19 11:19:59,339 - INFO - ya.test.421885  - pytest_runtest_setup: ####################################################################################################
2025-11-19 11:19:59,339 - INFO - ya.test.421885  - pytest_runtest_setup: test_all_supported_compression[zstd_18_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 18]
2025-11-19 11:19:59,340 - INFO - ya.test.421885  - pytest_runtest_setup: ####################################################################################################
2025-11-19 11:19:59,340 - INFO - ya.test.421885  - pytest_runtest_setup: Test setup
2025-11-19 11:19:59,342 - DEBUG - ya.test.421885  - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-19 11:19:59,343 - DEBUG - ya.test.421885  - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-19 11:19:59,344 - DEBUG - ya.test.421885  - execute: Executing '['/home/runner/.ya/build/build_root/pbux/001557/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-19 11:19:59,348 - DEBUG - ya.test.421885  - execute: Command pid: 422689
2025-11-19 11:20:00,211 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422689) rc: 0
2025-11-19 11:20:00,211 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422689) elapsed time (sec): 0.8612833023071289
2025-11-19 11:20:00,211 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422689) idrss: 0
2025-11-19 11:20:00,212 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422689) inblock: 0
2025-11-19 11:20:00,212 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422689) isrss: 0
2025-11-19 11:20:00,212 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422689) ixrss: 0
2025-11-19 11:20:00,213 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422689) majflt: 0
2025-11-19 11:20:00,213 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422689) maxrss: 492688
2025-11-19 11:20:00,214 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422689) minflt: 45365
2025-11-19 11:20:00,214 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422689) msgrcv: 0
2025-11-19 11:20:00,215 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422689) msgsnd: 0
2025-11-19 11:20:00,215 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422689) nivcsw: 150
2025-11-19 11:20:00,215 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422689) nsignals: 0
2025-11-19 11:20:00,216 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422689) nswap: 0
2025-11-19 11:20:00,216 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422689) nvcsw: 13
2025-11-19 11:20:00,216 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422689) oublock: 8
2025-11-19 11:20:00,216 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422689) stime: 0.21437499999999998
2025-11-19 11:20:00,217 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422689) utime: 0.558662
2025-11-19 11:20:00,217 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422689) wtime: 0.866
2025-11-19 11:20:00,217 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422689) 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-alsqrntpxi    Host information: 
        Linux ghrun-alsqrntpxi 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-19 11:20:00,218 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422689) errors:

2025-11-19 11:20:00,218 - INFO - __tests__.base.421885  - _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-alsqrntpxi    Host information: 
        Linux ghrun-alsqrntpxi 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-19 11:20:00,359 - DEBUG - ya.test.421885  - get_binary: Binary was found by /home/runner/.ya/build/build_root/pbux/001557/ydb/apps/ydbd/ydbd
2025-11-19 11:20:00,361 - DEBUG - library.python.filelock.421885  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/29407
2025-11-19 11:20:00,363 - DEBUG - ydb.tests.library.harness.kikimr_runner.421885  - start: Working directory: /home/runner/.ya/build/build_root/pbux/001557/r3tmp/kikimr_cluster_1mixwkgw
2025-11-19 11:20:00,403 - DEBUG - ya.test.421885  - get_binary: Binary was found by /home/runner/.ya/build/build_root/pbux/001557/ydb/apps/ydbd/ydbd
2025-11-19 11:20:00,404 - DEBUG - library.python.filelock.421885  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/9332
2025-11-19 11:20:00,404 - DEBUG - library.python.filelock.421885  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/14071
2025-11-19 11:20:00,405 - DEBUG - library.python.filelock.421885  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/62625
2025-11-19 11:20:00,405 - DEBUG - library.python.filelock.421885  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/4734
2025-11-19 11:20:00,406 - INFO - ydb.tests.library.harness.kikimr_runner.421885  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/pbux/001557/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk3/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_18_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.18/cluster/kikimr_configs"
2025-11-19 11:20:00,407 - INFO - ydb.tests.library.harness.kikimr_runner.421885  - __make_run_command: Final command: /home/runner/.ya/build/build_root/pbux/001557/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/pbux/001557/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk3/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_18_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.18/cluster/node_1/logfile_85dh_zz5.log --grpc-port=9332 --mon-port=14071 --ic-port=29407
2025-11-19 11:20:00,407 - DEBUG - ydb.tests.library.harness.kikimr_runner.421885  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:9332/1, disk_size 68719476736
2025-11-19 11:20:00,407 - INFO - ydb.tests.library.harness.kikimr_runner.421885  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/pbux/001557/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk3/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_18_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.18/cluster/kikimr_configs"
2025-11-19 11:20:00,408 - INFO - ydb.tests.library.harness.kikimr_runner.421885  - __make_run_command: Final command: /home/runner/.ya/build/build_root/pbux/001557/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/pbux/001557/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk3/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_18_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.18/cluster/node_1/logfile_85dh_zz5.log --grpc-port=9332 --mon-port=14071 --ic-port=29407
2025-11-19 11:20:00,409 - DEBUG - ya.test.421885  - execute: Executing '('/home/runner/.ya/build/build_root/pbux/001557/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/pbux/001557/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk3/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_18_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.18/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/pbux/001557/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk3/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_18_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.18/cluster/node_1/logfile_85dh_zz5.log', '--grpc-port=9332', '--mon-port=14071', '--ic-port=29407')' in '/home/runner/.ya/build/build_root/pbux/001557/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk3/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_18_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.18/cluster/node_1' (no wait)
2025-11-19 11:20:00,411 - DEBUG - ya.test.421885  - execute: Command pid: 422916
2025-11-19 11:20:00,412 - INFO - ydb.tests.library.harness.kikimr_runner.421885  - start: Started node localhost:9332/1
2025-11-19 11:20:00,413 - DEBUG - ya.test.421885  - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-19 11:20:00,414 - DEBUG - ya.test.421885  - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-19 11:20:00,414 - DEBUG - ya.test.421885  - execute: Executing '['/home/runner/.ya/build/build_root/pbux/001557/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-19 11:20:00,415 - DEBUG - ya.test.421885  - execute: Command pid: 422918
2025-11-19 11:20:01,388 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422918) rc: 0
2025-11-19 11:20:01,389 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422918) elapsed time (sec): 0.9719398021697998
2025-11-19 11:20:01,390 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422918) idrss: 0
2025-11-19 11:20:01,390 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422918) inblock: 0
2025-11-19 11:20:01,390 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422918) isrss: 0
2025-11-19 11:20:01,391 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422918) ixrss: 0
2025-11-19 11:20:01,391 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422918) majflt: 0
2025-11-19 11:20:01,391 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422918) maxrss: 493964
2025-11-19 11:20:01,392 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422918) minflt: 45365
2025-11-19 11:20:01,392 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422918) msgrcv: 0
2025-11-19 11:20:01,392 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422918) msgsnd: 0
2025-11-19 11:20:01,393 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422918) nivcsw: 185
2025-11-19 11:20:01,393 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422918) nsignals: 0
2025-11-19 11:20:01,396 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422918) nswap: 0
2025-11-19 11:20:01,396 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422918) nvcsw: 14
2025-11-19 11:20:01,397 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422918) oublock: 8
2025-11-19 11:20:01,397 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422918) stime: 0.241478
2025-11-19 11:20:01,397 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422918) utime: 0.532392
2025-11-19 11:20:01,398 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422918) wtime: 0.974
2025-11-19 11:20:01,398 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422918) 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-alsqrntpxi    Host information: 
        Linux ghrun-alsqrntpxi 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-19 11:20:01,398 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 422918) errors:

2025-11-19 11:20:01,401 - INFO - ydb.tests.library.harness.kikimr_runner.421885  - 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-alsqrntpxi    Host information: 
        Linux ghrun-alsqrntpxi 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64
2025-11-19 11:20:06,801 - DEBUG - ya.test.421885  - get_binary: Binary was found by /home/runner/.ya/build/build_root/pbux/001557/ydb/apps/ydbd/ydbd
2025-11-19 11:20:06,802 - DEBUG - ydb.tests.library.harness.kikimr_runner.421885  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/pbux/001557/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:9332', '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: 29407\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-19 11:20:06,803 - DEBUG - ya.test.421885  - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-19 11:20:06,804 - DEBUG - ya.test.421885  - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-19 11:20:06,805 - DEBUG - ya.test.421885  - execute: Executing '['/home/runner/.ya/build/build_root/pbux/001557/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:9332', '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: 29407\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-19 11:20:06,820 - DEBUG - ya.test.421885  - execute: Command pid: 424556
2025-11-19 11:20:07,980 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424556) rc: 0
2025-11-19 11:20:07,981 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424556) elapsed time (sec): 1.1594419479370117
2025-11-19 11:20:07,981 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424556) idrss: 0
2025-11-19 11:20:07,981 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424556) inblock: 0
2025-11-19 11:20:07,982 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424556) isrss: 0
2025-11-19 11:20:07,982 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424556) ixrss: 0
2025-11-19 11:20:07,982 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424556) majflt: 0
2025-11-19 11:20:07,983 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424556) maxrss: 600248
2025-11-19 11:20:07,983 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424556) minflt: 51529
2025-11-19 11:20:07,983 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424556) msgrcv: 0
2025-11-19 11:20:07,983 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424556) msgsnd: 0
2025-11-19 11:20:07,984 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424556) nivcsw: 204
2025-11-19 11:20:07,984 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424556) nsignals: 0
2025-11-19 11:20:07,984 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424556) nswap: 0
2025-11-19 11:20:07,985 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424556) nvcsw: 896
2025-11-19 11:20:07,985 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424556) oublock: 8
2025-11-19 11:20:07,985 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424556) stime: 0.300247
2025-11-19 11:20:07,986 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424556) utime: 0.5642429999999999
2025-11-19 11:20:07,986 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424556) wtime: 1.175
2025-11-19 11:20:07,986 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424556) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-19 11:20:07,987 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424556) errors:

2025-11-19 11:20:07,996 - DEBUG - ya.test.421885  - get_binary: Binary was found by /home/runner/.ya/build/build_root/pbux/001557/ydb/apps/ydbd/ydbd
2025-11-19 11:20:07,997 - DEBUG - ydb.tests.library.harness.kikimr_runner.421885  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/pbux/001557/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:9332', '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-19 11:20:07,998 - DEBUG - ya.test.421885  - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-19 11:20:08,001 - DEBUG - ya.test.421885  - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-19 11:20:08,001 - DEBUG - ya.test.421885  - execute: Executing '['/home/runner/.ya/build/build_root/pbux/001557/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:9332', '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-19 11:20:08,004 - DEBUG - ya.test.421885  - execute: Command pid: 424849
2025-11-19 11:20:09,093 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424849) rc: 0
2025-11-19 11:20:09,094 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424849) elapsed time (sec): 1.0886671543121338
2025-11-19 11:20:09,094 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424849) idrss: 0
2025-11-19 11:20:09,094 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424849) inblock: 0
2025-11-19 11:20:09,095 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424849) isrss: 0
2025-11-19 11:20:09,095 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424849) ixrss: 0
2025-11-19 11:20:09,095 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424849) majflt: 0
2025-11-19 11:20:09,095 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424849) maxrss: 600764
2025-11-19 11:20:09,096 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424849) minflt: 51767
2025-11-19 11:20:09,096 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424849) msgrcv: 0
2025-11-19 11:20:09,096 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424849) msgsnd: 0
2025-11-19 11:20:09,097 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424849) nivcsw: 144
2025-11-19 11:20:09,097 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424849) nsignals: 0
2025-11-19 11:20:09,097 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424849) nswap: 0
2025-11-19 11:20:09,098 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424849) nvcsw: 582
2025-11-19 11:20:09,098 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424849) oublock: 8
2025-11-19 11:20:09,098 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424849) stime: 0.24764499999999998
2025-11-19 11:20:09,098 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424849) utime: 0.607942
2025-11-19 11:20:09,099 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424849) wtime: 1.091
2025-11-19 11:20:09,099 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424849) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-11-19 11:20:09,099 - DEBUG - ya.test.421885  - _save_outputs: Command (pid 424849) errors:

2025-11-19 11:20:09,100 - INFO - ydb.tests.library.harness.kikimr_runner.421885  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-19 11:20:09,200 - INFO - ydb.tests.library.harness.kikimr_runner.421885  - __run: Cluster started and initialized
2025-11-19 11:20:09,243 - DEBUG - ydb.connection.421885  - 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-19 11:20:09,253 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.421885  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-19 11:20:09,254 - DEBUG - ydb.connection.421885  - 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-19 11:20:09,275 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.421885  - context_resolve: Resolving endpoints for database /Root
2025-11-19 11:20:09,276 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ListEndpoints, d441f63f-c690-47e4-a7af-7c9976b70549, localhost:9332): creating call state
2025-11-19 11:20:09,277 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ListEndpoints, d441f63f-c690-47e4-a7af-7c9976b70549, localhost:9332): request = { database: "/Root" }
2025-11-19 11:20:09,286 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ListEndpoints, d441f63f-c690-47e4-a7af-7c9976b70549, localhost:9332): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-alsqrntpxi.auto.internal" port: 9332 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-19 11:20:09,287 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.421885  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-alsqrntpxi.auto.internal:9332, location 1, ssl: False>]>
2025-11-19 11:20:09,290 - DEBUG - ydb.connection.421885  - 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-19 11:20:09,321 - DEBUG - ydb.connection.421885  - close: Closing channel for endpoint localhost:9332
2025-11-19 11:20:09,327 - DEBUG - ydb.query.pool.421885  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-19 11:20:09,329 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(CreateSession, 61aa3eef-6cc1-4293-9031-c4f2707bb58b, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:09,329 - DEBUG - ydb.connection.421885  - _log_request: RpcState(CreateSession, 61aa3eef-6cc1-4293-9031-c4f2707bb58b, ghrun-alsqrntpxi.auto.internal:9332): request = {  }
2025-11-19 11:20:09,341 - DEBUG - ydb.connection.421885  - _log_response: RpcState(CreateSession, 61aa3eef-6cc1-4293-9031-c4f2707bb58b, ghrun-alsqrntpxi.auto.internal:9332): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" node_id: 1 }
2025-11-19 11:20:09,342 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(AttachSession, bc9eb715-322a-402a-ac94-79c7beaf81dc, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:09,342 - DEBUG - ydb.connection.421885  - _log_request: RpcState(AttachSession, bc9eb715-322a-402a-ac94-79c7beaf81dc, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" }
2025-11-19 11:20:09,352 - DEBUG - ydb.connection.421885  - _log_response: RpcState(AttachSession, bc9eb715-322a-402a-ac94-79c7beaf81dc, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:09,364 - DEBUG - ydb.query.pool.421885  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:09,365 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, e2479faa-ca10-49e1-99bc-9f33a2684917, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:09,366 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, e2479faa-ca10-49e1-99bc-9f33a2684917, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:09,368 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, e2479faa-ca10-49e1-99bc-9f33a2684917, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:12,319 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:12,319 - INFO - __tests__.alter_compression.421885  - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-11-19 11:20:12,320 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:12,321 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, f0b840a3-f32e-4f30-bb98-9d07490e0642, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:12,322 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, f0b840a3-f32e-4f30-bb98-9d07490e0642, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:12,324 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, f0b840a3-f32e-4f30-bb98-9d07490e0642, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:13,266 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:13,267 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:13,268 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 55da9925-eb02-4ee9-9ab6-24b0ffadac5c, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:13,269 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 55da9925-eb02-4ee9-9ab6-24b0ffadac5c, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:13,270 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 55da9925-eb02-4ee9-9ab6-24b0ffadac5c, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:14,316 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:14,317 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:14,318 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 59619e59-2baf-42ee-97be-165e63afb6c8, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:14,318 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 59619e59-2baf-42ee-97be-165e63afb6c8, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:14,321 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 59619e59-2baf-42ee-97be-165e63afb6c8, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:15,282 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:15,283 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:15,284 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 9ccc9b89-7ba2-4b70-95f2-0be5b1c73f6b, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:15,285 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 9ccc9b89-7ba2-4b70-95f2-0be5b1c73f6b, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:15,286 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 9ccc9b89-7ba2-4b70-95f2-0be5b1c73f6b, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:16,677 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:16,678 - INFO - __tests__.alter_compression.421885  - 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-19 11:20:16,678 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:16,679 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 6d2b5ab5-0ff0-4d72-b009-763e6fd05c68, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:16,680 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 6d2b5ab5-0ff0-4d72-b009-763e6fd05c68, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:16,682 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 6d2b5ab5-0ff0-4d72-b009-763e6fd05c68, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:17,789 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:17,790 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:17,791 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, f5e09a37-8049-450e-b2d8-42a450a57f66, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:17,792 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, f5e09a37-8049-450e-b2d8-42a450a57f66, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:17,793 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, f5e09a37-8049-450e-b2d8-42a450a57f66, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:18,039 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:18,040 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:18,041 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 25b1c979-0a7d-401a-9607-c1fd0360d80e, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:18,042 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 25b1c979-0a7d-401a-9607-c1fd0360d80e, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:18,044 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 25b1c979-0a7d-401a-9607-c1fd0360d80e, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:18,460 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:18,462 - INFO - __tests__.alter_compression.421885  - 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-19 11:20:18,462 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:18,463 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 36c55d5e-d35d-475f-a9fa-77669f263063, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:18,464 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 36c55d5e-d35d-475f-a9fa-77669f263063, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:18,465 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 36c55d5e-d35d-475f-a9fa-77669f263063, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:19,503 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:19,504 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:19,505 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 7476818f-5e8b-47dc-919b-d7f5e7d29353, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:19,506 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 7476818f-5e8b-47dc-919b-d7f5e7d29353, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:19,508 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 7476818f-5e8b-47dc-919b-d7f5e7d29353, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:19,818 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:19,819 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:19,820 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 395465cc-ddc9-46aa-864e-ab39107b367b, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:19,821 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 395465cc-ddc9-46aa-864e-ab39107b367b, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:19,822 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 395465cc-ddc9-46aa-864e-ab39107b367b, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:20,222 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:20,222 - INFO - __tests__.alter_compression.421885  - 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-19 11:20:20,223 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:20,224 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 870d18a7-bab0-4583-83b3-b34872022e15, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:20,225 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 870d18a7-bab0-4583-83b3-b34872022e15, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:20,227 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 870d18a7-bab0-4583-83b3-b34872022e15, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:21,359 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:21,360 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:21,361 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 72ccb685-055b-4ee2-8895-ac3059a51357, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:21,362 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 72ccb685-055b-4ee2-8895-ac3059a51357, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:21,366 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 72ccb685-055b-4ee2-8895-ac3059a51357, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:21,737 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:21,738 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:21,739 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 5535f85b-e6a3-4f23-90bb-f68f0c6470ad, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:21,740 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 5535f85b-e6a3-4f23-90bb-f68f0c6470ad, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:21,743 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 5535f85b-e6a3-4f23-90bb-f68f0c6470ad, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:22,194 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:22,195 - INFO - __tests__.alter_compression.421885  - 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-19 11:20:22,195 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:22,196 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, db908e22-5f61-41fc-a34f-2cb7eb77a837, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:22,197 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, db908e22-5f61-41fc-a34f-2cb7eb77a837, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:22,198 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, db908e22-5f61-41fc-a34f-2cb7eb77a837, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:23,242 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:23,243 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:23,245 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, afa3cf38-544b-46d1-b522-22ea97864fc3, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:23,246 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, afa3cf38-544b-46d1-b522-22ea97864fc3, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:23,249 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, afa3cf38-544b-46d1-b522-22ea97864fc3, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:23,633 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:23,633 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:23,634 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 0cfdd896-827c-4363-ad21-720379bc7c7a, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:23,635 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 0cfdd896-827c-4363-ad21-720379bc7c7a, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:23,637 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 0cfdd896-827c-4363-ad21-720379bc7c7a, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:24,752 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:24,753 - INFO - __tests__.alter_compression.421885  - 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-19 11:20:24,754 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:24,754 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 03c6bb8d-54f4-4e24-9fa9-e579005e94e7, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:24,755 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 03c6bb8d-54f4-4e24-9fa9-e579005e94e7, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:24,757 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 03c6bb8d-54f4-4e24-9fa9-e579005e94e7, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:25,900 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:25,901 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:25,902 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 16ab21bc-48b8-4149-8df0-f8cda6f23705, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:25,902 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 16ab21bc-48b8-4149-8df0-f8cda6f23705, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:25,904 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 16ab21bc-48b8-4149-8df0-f8cda6f23705, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:26,148 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:26,149 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:26,150 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 55be558e-659e-4f90-92a5-79a927c2e73c, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:26,151 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 55be558e-659e-4f90-92a5-79a927c2e73c, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:26,158 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 55be558e-659e-4f90-92a5-79a927c2e73c, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:26,800 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:26,801 - INFO - __tests__.alter_compression.421885  - 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-19 11:20:26,801 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:26,802 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, eec1523a-40c8-45f8-b617-fcef5e27d6f4, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:26,802 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, eec1523a-40c8-45f8-b617-fcef5e27d6f4, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:26,803 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, eec1523a-40c8-45f8-b617-fcef5e27d6f4, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:28,011 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:28,012 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:28,012 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 7b27d56e-1969-4ed7-a4bc-87f435e570a9, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:28,013 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 7b27d56e-1969-4ed7-a4bc-87f435e570a9, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:28,014 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 7b27d56e-1969-4ed7-a4bc-87f435e570a9, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:28,427 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:28,428 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:28,429 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 3a5d045b-ebf0-4bfa-a7f2-4c9964fdf36e, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:28,429 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 3a5d045b-ebf0-4bfa-a7f2-4c9964fdf36e, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:28,432 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 3a5d045b-ebf0-4bfa-a7f2-4c9964fdf36e, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:29,124 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:29,125 - INFO - __tests__.alter_compression.421885  - 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-19 11:20:29,125 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:29,126 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, ab8d74ad-72f7-4506-a669-4de32094c8e1, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:29,127 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, ab8d74ad-72f7-4506-a669-4de32094c8e1, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:29,129 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, ab8d74ad-72f7-4506-a669-4de32094c8e1, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:30,328 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:30,329 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:30,330 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 306c0555-3735-4956-bc5a-a364cef334b2, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:30,331 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 306c0555-3735-4956-bc5a-a364cef334b2, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:30,332 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 306c0555-3735-4956-bc5a-a364cef334b2, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:30,586 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:30,587 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:30,588 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 3e8fb1a5-ccdd-40b6-91d8-0b5328cafa13, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:30,590 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 3e8fb1a5-ccdd-40b6-91d8-0b5328cafa13, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:30,593 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 3e8fb1a5-ccdd-40b6-91d8-0b5328cafa13, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:31,193 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:31,194 - INFO - __tests__.alter_compression.421885  - 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-19 11:20:31,194 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:31,195 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 7c0ae916-fd67-45df-ac17-cb2bccf49c6a, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:31,204 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 7c0ae916-fd67-45df-ac17-cb2bccf49c6a, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:31,206 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 7c0ae916-fd67-45df-ac17-cb2bccf49c6a, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:32,449 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:32,450 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:32,451 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, b5bd01ce-4844-4301-bd39-7aaef84457c9, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:32,452 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, b5bd01ce-4844-4301-bd39-7aaef84457c9, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:32,453 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, b5bd01ce-4844-4301-bd39-7aaef84457c9, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:32,722 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:32,723 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:32,723 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 89319e6e-dbe8-49de-b7df-db921701f02a, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:32,724 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 89319e6e-dbe8-49de-b7df-db921701f02a, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:32,726 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 89319e6e-dbe8-49de-b7df-db921701f02a, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:33,586 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:33,587 - INFO - __tests__.alter_compression.421885  - 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-19 11:20:33,588 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:33,589 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 78c0c051-bd06-4d1b-baad-384769cf4900, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:33,590 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 78c0c051-bd06-4d1b-baad-384769cf4900, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:33,593 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 78c0c051-bd06-4d1b-baad-384769cf4900, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:34,829 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:34,830 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:34,830 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 31a93805-63bd-4fc5-aadd-e0314c33ed83, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:34,832 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 31a93805-63bd-4fc5-aadd-e0314c33ed83, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:34,833 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 31a93805-63bd-4fc5-aadd-e0314c33ed83, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:35,151 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:35,153 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:35,153 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 7280149d-0da3-4699-8604-4fce9bb2fe55, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:35,154 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 7280149d-0da3-4699-8604-4fce9bb2fe55, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:35,156 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 7280149d-0da3-4699-8604-4fce9bb2fe55, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:35,766 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:35,767 - INFO - __tests__.alter_compression.421885  - 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-19 11:20:35,767 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:35,768 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 6ad57245-40ac-4dc0-b695-2d03793c8805, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:35,769 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 6ad57245-40ac-4dc0-b695-2d03793c8805, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:35,771 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 6ad57245-40ac-4dc0-b695-2d03793c8805, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:36,832 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:36,833 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:36,834 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 7c8bf4ff-7f63-421a-9fae-2839bb9d88b8, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:36,835 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 7c8bf4ff-7f63-421a-9fae-2839bb9d88b8, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:36,837 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 7c8bf4ff-7f63-421a-9fae-2839bb9d88b8, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:37,044 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:37,045 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:37,046 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, faee738f-0249-4c77-a268-776b24c44651, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:37,047 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, faee738f-0249-4c77-a268-776b24c44651, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:37,048 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, faee738f-0249-4c77-a268-776b24c44651, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:37,312 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:37,313 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:37,314 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 86086cd8-8d18-49fd-993b-22e2d83613d8, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:37,315 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 86086cd8-8d18-49fd-993b-22e2d83613d8, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:37,316 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 86086cd8-8d18-49fd-993b-22e2d83613d8, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:41,038 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:51,076 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:51,077 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, c7f3724a-1f06-4a59-9bf1-bf30d464938e, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:51,078 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, c7f3724a-1f06-4a59-9bf1-bf30d464938e, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:51,080 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, c7f3724a-1f06-4a59-9bf1-bf30d464938e, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:54,196 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:54,230 - INFO - root.421885  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-19 11:20:54,230 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:20:54,231 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 2528c87f-f3f2-46d2-9670-61eda5935152, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:20:54,232 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 2528c87f-f3f2-46d2-9670-61eda5935152, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:20:54,233 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 2528c87f-f3f2-46d2-9670-61eda5935152, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:20:57,103 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:07,145 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:07,146 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, ba7cbf4d-08d2-4e20-a0e0-21564b9a910c, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:21:07,147 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, ba7cbf4d-08d2-4e20-a0e0-21564b9a910c, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:21:07,148 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, ba7cbf4d-08d2-4e20-a0e0-21564b9a910c, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:10,435 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:10,472 - INFO - root.421885  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-19 11:21:10,473 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:10,474 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 1127c0e7-b10d-47c5-9eee-e32130222095, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:21:10,475 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 1127c0e7-b10d-47c5-9eee-e32130222095, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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-19 11:21:10,478 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 1127c0e7-b10d-47c5-9eee-e32130222095, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:10,779 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:10,805 - INFO - ya.test.421885  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_18_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 18])
2025-11-19 11:21:10,806 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:10,807 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 6ff76563-1450-46c1-bbf5-05fb5e631035, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:21:10,808 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 6ff76563-1450-46c1-bbf5-05fb5e631035, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_18_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 18)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:10,809 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 6ff76563-1450-46c1-bbf5-05fb5e631035, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:14,457 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:14,458 - INFO - __tests__.alter_compression.421885  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_18_compression created
2025-11-19 11:21:14,458 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:14,459 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 5e6ccad1-6f2f-44fc-b984-eec8b68b1a1c, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:21:14,460 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 5e6ccad1-6f2f-44fc-b984-eec8b68b1a1c, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_18_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:14,462 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 5e6ccad1-6f2f-44fc-b984-eec8b68b1a1c, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:15,242 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:15,243 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:15,243 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 9338c71b-d158-42e2-af18-b351fcd16a8a, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:21:15,244 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 9338c71b-d158-42e2-af18-b351fcd16a8a, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:15,245 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 9338c71b-d158-42e2-af18-b351fcd16a8a, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:19,405 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:19,405 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:19,406 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, cf651db8-e614-448c-a3c4-2ddfe93c3823, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:21:19,406 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, cf651db8-e614-448c-a3c4-2ddfe93c3823, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:19,407 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, cf651db8-e614-448c-a3c4-2ddfe93c3823, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:20,391 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:20,392 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:20,393 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 69690085-0900-46d3-98d9-41ec518f2428, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:21:20,394 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 69690085-0900-46d3-98d9-41ec518f2428, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:20,395 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 69690085-0900-46d3-98d9-41ec518f2428, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:22,072 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:22,072 - INFO - __tests__.alter_compression.421885  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318528, 'BlobCount': 128}}
2025-11-19 11:21:22,073 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:22,073 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 2c64fd93-9e3f-442c-8d3b-faffa3ae7600, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:21:22,074 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 2c64fd93-9e3f-442c-8d3b-faffa3ae7600, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:22,075 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 2c64fd93-9e3f-442c-8d3b-faffa3ae7600, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:25,876 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:25,876 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:25,877 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, e27349af-25ba-4e9c-b0f4-1b2f0d82b784, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:21:25,877 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, e27349af-25ba-4e9c-b0f4-1b2f0d82b784, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:25,878 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, e27349af-25ba-4e9c-b0f4-1b2f0d82b784, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:26,184 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:26,185 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:26,185 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, a223da34-dba9-46db-ae53-99f0fa385d53, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:21:26,186 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, a223da34-dba9-46db-ae53-99f0fa385d53, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:26,188 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, a223da34-dba9-46db-ae53-99f0fa385d53, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:26,497 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:26,498 - INFO - __tests__.alter_compression.421885  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 637920, 'BlobCount': 256}}
2025-11-19 11:21:26,498 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:26,498 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 5b0ee59a-bc3c-41da-aae7-7c4bbe10a157, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:21:26,499 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 5b0ee59a-bc3c-41da-aae7-7c4bbe10a157, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:26,500 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 5b0ee59a-bc3c-41da-aae7-7c4bbe10a157, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:30,816 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:30,825 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:30,829 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 319272b8-3854-47d4-a1a3-eab83e163dfc, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:21:30,830 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 319272b8-3854-47d4-a1a3-eab83e163dfc, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:30,831 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 319272b8-3854-47d4-a1a3-eab83e163dfc, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:31,204 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:31,221 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:31,221 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, f7f4ce89-dc0a-4886-b23d-1fc85e83bece, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:21:31,222 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, f7f4ce89-dc0a-4886-b23d-1fc85e83bece, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:31,225 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, f7f4ce89-dc0a-4886-b23d-1fc85e83bece, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:31,631 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:31,632 - INFO - __tests__.alter_compression.421885  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 956816, 'BlobCount': 384}}
2025-11-19 11:21:31,632 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:31,633 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 4e338ec2-ad42-491f-bc16-140156005eb5, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:21:31,634 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 4e338ec2-ad42-491f-bc16-140156005eb5, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:31,635 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 4e338ec2-ad42-491f-bc16-140156005eb5, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:36,032 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.421885  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-19 11:21:36,033 - DEBUG - ydb.connection.421885  - 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-19 11:21:36,060 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.421885  - context_resolve: Resolving endpoints for database /Root
2025-11-19 11:21:36,060 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ListEndpoints, 30e8dba3-02df-4b58-ab88-70078e75ae06, localhost:9332): creating call state
2025-11-19 11:21:36,061 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ListEndpoints, 30e8dba3-02df-4b58-ab88-70078e75ae06, localhost:9332): request = { database: "/Root" }
2025-11-19 11:21:36,073 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ListEndpoints, 30e8dba3-02df-4b58-ab88-70078e75ae06, localhost:9332): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-alsqrntpxi.auto.internal" port: 9332 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-19 11:21:36,074 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.421885  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-alsqrntpxi.auto.internal:9332, location 1, ssl: False>]>
2025-11-19 11:21:36,074 - DEBUG - ydb.connection.421885  - close: Closing channel for endpoint localhost:9332
2025-11-19 11:21:36,454 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:36,455 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:36,456 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 82221c82-0513-4c15-91c5-497146c65e36, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:21:36,457 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 82221c82-0513-4c15-91c5-497146c65e36, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:36,460 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 82221c82-0513-4c15-91c5-497146c65e36, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:36,760 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:36,761 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:36,762 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 6e04c16a-8d37-4dc7-9096-f965e5f4b734, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:21:36,763 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 6e04c16a-8d37-4dc7-9096-f965e5f4b734, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:36,764 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 6e04c16a-8d37-4dc7-9096-f965e5f4b734, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:37,197 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:37,198 - INFO - __tests__.alter_compression.421885  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1276240, 'BlobCount': 512}}
2025-11-19 11:21:37,199 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:37,200 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 60a8e005-46dd-4d8e-add5-22ac0d28c439, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:21:37,202 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 60a8e005-46dd-4d8e-add5-22ac0d28c439, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:37,204 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 60a8e005-46dd-4d8e-add5-22ac0d28c439, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:41,412 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:41,413 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:41,413 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, c42c9b91-8e26-46c8-8c29-f00fff8ad30b, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:21:41,414 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, c42c9b91-8e26-46c8-8c29-f00fff8ad30b, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:41,415 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, c42c9b91-8e26-46c8-8c29-f00fff8ad30b, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:41,688 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:41,689 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:41,690 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, c92db03e-3f69-4006-804a-823303c0c7e2, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:21:41,691 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, c92db03e-3f69-4006-804a-823303c0c7e2, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:41,692 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, c92db03e-3f69-4006-804a-823303c0c7e2, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:42,206 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:42,207 - INFO - __tests__.alter_compression.421885  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1595136, 'BlobCount': 640}}
2025-11-19 11:21:42,207 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:42,208 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 8f737919-aa2b-4440-9099-f5a84220745e, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:21:42,209 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 8f737919-aa2b-4440-9099-f5a84220745e, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:42,220 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 8f737919-aa2b-4440-9099-f5a84220745e, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:45,782 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:45,783 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:45,784 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 8d676b06-cca7-47eb-a256-ee00e30fd74a, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:21:45,785 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 8d676b06-cca7-47eb-a256-ee00e30fd74a, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:45,786 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 8d676b06-cca7-47eb-a256-ee00e30fd74a, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:46,040 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:46,041 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:46,041 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 666e3f6c-60ea-4635-a349-5c025ab90768, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:21:46,044 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 666e3f6c-60ea-4635-a349-5c025ab90768, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:46,046 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 666e3f6c-60ea-4635-a349-5c025ab90768, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:46,522 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:46,523 - INFO - __tests__.alter_compression.421885  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1914416, 'BlobCount': 768}}
2025-11-19 11:21:46,523 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:46,524 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 77e21a9d-0e0f-4cbb-a9bc-9295246d4ea1, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:21:46,525 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 77e21a9d-0e0f-4cbb-a9bc-9295246d4ea1, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:46,527 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 77e21a9d-0e0f-4cbb-a9bc-9295246d4ea1, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:50,022 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:50,022 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:50,023 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, c2d80376-4f86-4ba6-be5f-f4050b168f17, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:21:50,024 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, c2d80376-4f86-4ba6-be5f-f4050b168f17, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:50,025 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, c2d80376-4f86-4ba6-be5f-f4050b168f17, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:50,256 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:50,257 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:50,258 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 7a81cbda-9a47-4099-bdd6-a157e2809f95, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:21:50,259 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 7a81cbda-9a47-4099-bdd6-a157e2809f95, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:50,260 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 7a81cbda-9a47-4099-bdd6-a157e2809f95, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:50,743 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:50,743 - INFO - __tests__.alter_compression.421885  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2233456, 'BlobCount': 896}}
2025-11-19 11:21:50,744 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:50,745 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, d3df51b2-6617-4b88-bf68-b1bc3cfef126, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:21:50,745 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, d3df51b2-6617-4b88-bf68-b1bc3cfef126, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:50,747 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, d3df51b2-6617-4b88-bf68-b1bc3cfef126, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:54,359 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:54,365 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:54,366 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, bdd83f12-df58-4353-8fa8-20bc60c55542, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:21:54,367 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, bdd83f12-df58-4353-8fa8-20bc60c55542, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:54,369 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, bdd83f12-df58-4353-8fa8-20bc60c55542, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:54,663 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:54,663 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:54,664 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, ad84938a-1376-4118-b69e-7d2550328cd0, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:21:54,665 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, ad84938a-1376-4118-b69e-7d2550328cd0, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:54,668 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, ad84938a-1376-4118-b69e-7d2550328cd0, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:21:55,260 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:55,261 - INFO - __tests__.alter_compression.421885  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2552960, 'BlobCount': 1024}}
2025-11-19 11:21:55,262 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:21:55,262 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 103e7b28-536b-44de-832b-7c1ce7d0da5e, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:21:55,263 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 103e7b28-536b-44de-832b-7c1ce7d0da5e, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:21:55,265 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 103e7b28-536b-44de-832b-7c1ce7d0da5e, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:00,845 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:22:00,846 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:22:00,847 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 797b9582-2690-45e3-accc-62e12b76998e, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:22:00,848 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 797b9582-2690-45e3-accc-62e12b76998e, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:22:00,850 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 797b9582-2690-45e3-accc-62e12b76998e, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:01,586 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:22:01,587 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:22:01,588 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 06189dfc-0ccf-4d3f-b866-51ee403183aa, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:22:01,589 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 06189dfc-0ccf-4d3f-b866-51ee403183aa, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:22:01,624 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 06189dfc-0ccf-4d3f-b866-51ee403183aa, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:04,012 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:22:04,013 - INFO - __tests__.alter_compression.421885  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2871840, 'BlobCount': 1152}}
2025-11-19 11:22:04,013 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:22:04,014 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 848ca3aa-7eec-43a7-8e73-ece46caebaa7, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:22:04,015 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 848ca3aa-7eec-43a7-8e73-ece46caebaa7, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:22:04,016 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 848ca3aa-7eec-43a7-8e73-ece46caebaa7, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:15,869 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:22:15,870 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:22:15,870 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 24a7ab38-ec0c-4b86-af34-3131d78c3e78, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:22:15,871 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 24a7ab38-ec0c-4b86-af34-3131d78c3e78, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:22:15,876 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 24a7ab38-ec0c-4b86-af34-3131d78c3e78, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:16,608 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:22:16,609 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:22:16,610 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 479436bc-1d9d-4c49-8420-ec79dc5766f0, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:22:16,611 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 479436bc-1d9d-4c49-8420-ec79dc5766f0, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-19 11:22:16,613 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 479436bc-1d9d-4c49-8420-ec79dc5766f0, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:18,256 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:22:18,257 - INFO - __tests__.alter_compression.421885  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_18_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3191408, 'BlobCount': 1280}}
2025-11-19 11:22:18,258 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:22:18,258 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 99969ce8-d8d2-4a5d-9695-12e994564afe, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:22:18,259 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 99969ce8-d8d2-4a5d-9695-12e994564afe, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_18_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:22:18,261 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 99969ce8-d8d2-4a5d-9695-12e994564afe, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:20,201 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:22:20,202 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:22:20,203 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 72c41345-805d-469f-9e56-bd098977aae4, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:22:20,203 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 72c41345-805d-469f-9e56-bd098977aae4, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:22:20,205 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 72c41345-805d-469f-9e56-bd098977aae4, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:21,095 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:22:21,096 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:22:21,097 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 13be222c-9cd1-4882-895d-fd5e9858db6f, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:22:21,098 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 13be222c-9cd1-4882-895d-fd5e9858db6f, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:22:21,102 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 13be222c-9cd1-4882-895d-fd5e9858db6f, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:21,489 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:22:21,490 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:22:21,490 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, fccb8bbc-8575-45a9-9bb9-1b0d2284fe29, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:22:21,491 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, fccb8bbc-8575-45a9-9bb9-1b0d2284fe29, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_18_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:22:21,503 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, fccb8bbc-8575-45a9-9bb9-1b0d2284fe29, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:29,287 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:22:39,412 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:22:39,413 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, cc2ebc0d-46a1-438a-b3f7-ce030fb16a9c, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:22:39,414 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, cc2ebc0d-46a1-438a-b3f7-ce030fb16a9c, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_18_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:22:39,416 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, cc2ebc0d-46a1-438a-b3f7-ce030fb16a9c, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:45,056 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:22:45,102 - INFO - root.421885  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_18_compression`, volumes `value` (8000000, 1595704)
2025-11-19 11:22:45,102 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:22:45,103 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 9022986f-5ed3-4a47-a71e-c0bad438fbb8, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:22:45,105 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 9022986f-5ed3-4a47-a71e-c0bad438fbb8, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" 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_18_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:22:45,106 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 9022986f-5ed3-4a47-a71e-c0bad438fbb8, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:45,590 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:22:45,591 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:22:45,592 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, 0a1a8a7b-0300-42d6-8055-3c48098521ff, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:22:45,592 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, 0a1a8a7b-0300-42d6-8055-3c48098521ff, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_18_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:22:45,594 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, 0a1a8a7b-0300-42d6-8055-3c48098521ff, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:22:52,058 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:23:02,140 - DEBUG - ydb.query.pool.421885  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:23:02,141 - DEBUG - ydb.connection.421885  - _prepare_call: RpcState(ExecuteQuery, d5185540-4545-4fd8-b030-dd91992a0c47, ghrun-alsqrntpxi.auto.internal:9332): creating call state
2025-11-19 11:23:02,142 - DEBUG - ydb.connection.421885  - _log_request: RpcState(ExecuteQuery, d5185540-4545-4fd8-b030-dd91992a0c47, ghrun-alsqrntpxi.auto.internal:9332): request = { session_id: "ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_18_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-19 11:23:02,151 - DEBUG - ydb.connection.421885  - _log_response: RpcState(ExecuteQuery, d5185540-4545-4fd8-b030-dd91992a0c47, ghrun-alsqrntpxi.auto.internal:9332): response = { <_MultiThreadedRendezvous object> }
2025-11-19 11:23:09,154 - DEBUG - ydb.query.pool.421885  - release: Session returned to queue: ydb://session/3?node_id=1&id=Y2Y1OGNmMjgtODQ3ZTQwZDktYzY1MmQyNjctNjAxYzdkNzY=
2025-11-19 11:23:09,215 - INFO - root.421885  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_18_compression`, volumes `value` (8000000, 1595704)
2025-11-19 11:23:09,216 - INFO - root.421885  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_18_compression` 8092160 / 1595704: 5.071216215538722
2025-11-19 11:23:09,218 - INFO - ya.test.421885  - pytest_runtest_teardown: Test teardown
