2025-12-04 21:00:22,750 - INFO - ya.test.625937  - pytest_runtest_setup: ####################################################################################################
2025-12-04 21:00:22,750 - INFO - ya.test.625937  - pytest_runtest_setup: test_all_supported_compression[zstd_4_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 4]
2025-12-04 21:00:22,751 - INFO - ya.test.625937  - pytest_runtest_setup: ####################################################################################################
2025-12-04 21:00:22,751 - INFO - ya.test.625937  - pytest_runtest_setup: Test setup
2025-12-04 21:00:22,752 - DEBUG - ya.test.625937  - _get_command_output_file: Command out will be placed to ydbd.out
2025-12-04 21:00:22,753 - DEBUG - ya.test.625937  - _get_command_output_file: Command err will be placed to ydbd.err
2025-12-04 21:00:22,754 - DEBUG - ya.test.625937  - execute: Executing '['/home/runner/.ya/build/build_root/uyxd/001d62/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-04 21:00:22,755 - DEBUG - ya.test.625937  - execute: Command pid: 630342
2025-12-04 21:00:23,436 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630342) rc: 0
2025-12-04 21:00:23,437 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630342) elapsed time (sec): 0.6802446842193604
2025-12-04 21:00:23,437 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630342) idrss: 0
2025-12-04 21:00:23,437 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630342) inblock: 0
2025-12-04 21:00:23,437 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630342) isrss: 0
2025-12-04 21:00:23,438 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630342) ixrss: 0
2025-12-04 21:00:23,438 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630342) majflt: 0
2025-12-04 21:00:23,438 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630342) maxrss: 501564
2025-12-04 21:00:23,438 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630342) minflt: 45656
2025-12-04 21:00:23,439 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630342) msgrcv: 0
2025-12-04 21:00:23,439 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630342) msgsnd: 0
2025-12-04 21:00:23,439 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630342) nivcsw: 10
2025-12-04 21:00:23,439 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630342) nsignals: 0
2025-12-04 21:00:23,440 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630342) nswap: 0
2025-12-04 21:00:23,440 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630342) nvcsw: 14
2025-12-04 21:00:23,440 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630342) oublock: 8
2025-12-04 21:00:23,440 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630342) stime: 0.199827
2025-12-04 21:00:23,440 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630342) utime: 0.43062999999999996
2025-12-04 21:00:23,441 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630342) wtime: 0.682
2025-12-04 21:00:23,441 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630342) output:
Git info:
    Commit: 90dd67a37cfb741f29eee0fef0c766380665ddfd
    Branch: 
    Author: Pavel Velikhov <pavel.velikhov@gmail.com>
    Summary: Merge 0d970fa1db908c828a42e48f6775426d76a77466 into e654da9fb4dc56d3ce85e2435d2c2c6f4757aa6d
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-fryxcz52gi    Host information: 
        Linux ghrun-fryxcz52gi 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-12-04 21:00:23,441 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630342) errors:

2025-12-04 21:00:23,441 - INFO - __tests__.base.625937  - _setup_ydb: Git info:
    Commit: 90dd67a37cfb741f29eee0fef0c766380665ddfd
    Branch: 
    Author: Pavel Velikhov <pavel.velikhov@gmail.com>
    Summary: Merge 0d970fa1db908c828a42e48f6775426d76a77466 into e654da9fb4dc56d3ce85e2435d2c2c6f4757aa6d
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-fryxcz52gi    Host information: 
        Linux ghrun-fryxcz52gi 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-12-04 21:00:23,536 - DEBUG - ya.test.625937  - get_binary: Binary was found by /home/runner/.ya/build/build_root/uyxd/001d62/ydb/apps/ydbd/ydbd
2025-12-04 21:00:23,537 - DEBUG - library.python.filelock.625937  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/5041
2025-12-04 21:00:23,539 - DEBUG - ydb.tests.library.harness.kikimr_runner.625937  - start: Working directory: /home/runner/.ya/build/build_root/uyxd/001d62/r3tmp/kikimr_cluster_ypbxc3eh
2025-12-04 21:00:23,579 - DEBUG - ya.test.625937  - get_binary: Binary was found by /home/runner/.ya/build/build_root/uyxd/001d62/ydb/apps/ydbd/ydbd
2025-12-04 21:00:23,579 - DEBUG - library.python.filelock.625937  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/24695
2025-12-04 21:00:23,580 - DEBUG - library.python.filelock.625937  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/30883
2025-12-04 21:00:23,580 - DEBUG - library.python.filelock.625937  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/26660
2025-12-04 21:00:23,581 - DEBUG - library.python.filelock.625937  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18859
2025-12-04 21:00:23,582 - INFO - ydb.tests.library.harness.kikimr_runner.625937  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/uyxd/001d62/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/kikimr_configs"
2025-12-04 21:00:23,582 - INFO - ydb.tests.library.harness.kikimr_runner.625937  - __make_run_command: Final command: /home/runner/.ya/build/build_root/uyxd/001d62/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/uyxd/001d62/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/node_1/logfile_u3bl45i2.log --grpc-port=24695 --mon-port=30883 --ic-port=5041
2025-12-04 21:00:23,582 - DEBUG - ydb.tests.library.harness.kikimr_runner.625937  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:24695/1, disk_size 68719476736
2025-12-04 21:00:23,583 - INFO - ydb.tests.library.harness.kikimr_runner.625937  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/uyxd/001d62/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/kikimr_configs"
2025-12-04 21:00:23,583 - INFO - ydb.tests.library.harness.kikimr_runner.625937  - __make_run_command: Final command: /home/runner/.ya/build/build_root/uyxd/001d62/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/uyxd/001d62/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/node_1/logfile_u3bl45i2.log --grpc-port=24695 --mon-port=30883 --ic-port=5041
2025-12-04 21:00:23,584 - DEBUG - ya.test.625937  - execute: Executing '('/home/runner/.ya/build/build_root/uyxd/001d62/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/uyxd/001d62/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/uyxd/001d62/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/node_1/logfile_u3bl45i2.log', '--grpc-port=24695', '--mon-port=30883', '--ic-port=5041')' in '/home/runner/.ya/build/build_root/uyxd/001d62/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_4_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.4/cluster/node_1' (no wait)
2025-12-04 21:00:23,587 - DEBUG - ya.test.625937  - execute: Command pid: 630718
2025-12-04 21:00:23,587 - INFO - ydb.tests.library.harness.kikimr_runner.625937  - start: Started node localhost:24695/1
2025-12-04 21:00:23,589 - DEBUG - ya.test.625937  - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-12-04 21:00:23,590 - DEBUG - ya.test.625937  - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-12-04 21:00:23,590 - DEBUG - ya.test.625937  - execute: Executing '['/home/runner/.ya/build/build_root/uyxd/001d62/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-04 21:00:23,591 - DEBUG - ya.test.625937  - execute: Command pid: 630720
2025-12-04 21:00:24,272 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630720) rc: 0
2025-12-04 21:00:24,272 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630720) elapsed time (sec): 0.679781436920166
2025-12-04 21:00:24,273 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630720) idrss: 0
2025-12-04 21:00:24,273 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630720) inblock: 0
2025-12-04 21:00:24,273 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630720) isrss: 0
2025-12-04 21:00:24,274 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630720) ixrss: 0
2025-12-04 21:00:24,274 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630720) majflt: 0
2025-12-04 21:00:24,274 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630720) maxrss: 511732
2025-12-04 21:00:24,274 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630720) minflt: 45656
2025-12-04 21:00:24,275 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630720) msgrcv: 0
2025-12-04 21:00:24,275 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630720) msgsnd: 0
2025-12-04 21:00:24,275 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630720) nivcsw: 54
2025-12-04 21:00:24,275 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630720) nsignals: 0
2025-12-04 21:00:24,276 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630720) nswap: 0
2025-12-04 21:00:24,276 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630720) nvcsw: 15
2025-12-04 21:00:24,276 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630720) oublock: 8
2025-12-04 21:00:24,276 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630720) stime: 0.188916
2025-12-04 21:00:24,277 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630720) utime: 0.43581
2025-12-04 21:00:24,277 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630720) wtime: 0.681
2025-12-04 21:00:24,277 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630720) output:
Git info:
    Commit: 90dd67a37cfb741f29eee0fef0c766380665ddfd
    Branch: 
    Author: Pavel Velikhov <pavel.velikhov@gmail.com>
    Summary: Merge 0d970fa1db908c828a42e48f6775426d76a77466 into e654da9fb4dc56d3ce85e2435d2c2c6f4757aa6d
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-fryxcz52gi    Host information: 
        Linux ghrun-fryxcz52gi 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-12-04 21:00:24,277 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 630720) errors:

2025-12-04 21:00:24,278 - INFO - ydb.tests.library.harness.kikimr_runner.625937  - start: Node 1 version:
Git info:
    Commit: 90dd67a37cfb741f29eee0fef0c766380665ddfd
    Branch: 
    Author: Pavel Velikhov <pavel.velikhov@gmail.com>
    Summary: Merge 0d970fa1db908c828a42e48f6775426d76a77466 into e654da9fb4dc56d3ce85e2435d2c2c6f4757aa6d
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-fryxcz52gi    Host information: 
        Linux ghrun-fryxcz52gi 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64
2025-12-04 21:00:26,856 - DEBUG - ya.test.625937  - get_binary: Binary was found by /home/runner/.ya/build/build_root/uyxd/001d62/ydb/apps/ydbd/ydbd
2025-12-04 21:00:26,857 - DEBUG - ydb.tests.library.harness.kikimr_runner.625937  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/uyxd/001d62/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:24695', '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: 5041\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-12-04 21:00:26,858 - DEBUG - ya.test.625937  - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-12-04 21:00:26,859 - DEBUG - ya.test.625937  - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-12-04 21:00:26,859 - DEBUG - ya.test.625937  - execute: Executing '['/home/runner/.ya/build/build_root/uyxd/001d62/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:24695', '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: 5041\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-12-04 21:00:26,868 - DEBUG - ya.test.625937  - execute: Command pid: 631781
2025-12-04 21:00:27,723 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631781) rc: 0
2025-12-04 21:00:27,724 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631781) elapsed time (sec): 0.8543963432312012
2025-12-04 21:00:27,724 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631781) idrss: 0
2025-12-04 21:00:27,724 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631781) inblock: 0
2025-12-04 21:00:27,725 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631781) isrss: 0
2025-12-04 21:00:27,725 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631781) ixrss: 0
2025-12-04 21:00:27,725 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631781) majflt: 0
2025-12-04 21:00:27,726 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631781) maxrss: 578276
2025-12-04 21:00:27,726 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631781) minflt: 52055
2025-12-04 21:00:27,726 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631781) msgrcv: 0
2025-12-04 21:00:27,727 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631781) msgsnd: 0
2025-12-04 21:00:27,727 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631781) nivcsw: 103
2025-12-04 21:00:27,727 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631781) nsignals: 0
2025-12-04 21:00:27,728 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631781) nswap: 0
2025-12-04 21:00:27,728 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631781) nvcsw: 563
2025-12-04 21:00:27,728 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631781) oublock: 8
2025-12-04 21:00:27,728 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631781) stime: 0.22874899999999998
2025-12-04 21:00:27,729 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631781) utime: 0.532725
2025-12-04 21:00:27,729 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631781) wtime: 0.863
2025-12-04 21:00:27,729 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631781) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-12-04 21:00:27,730 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631781) errors:

2025-12-04 21:00:27,731 - DEBUG - ya.test.625937  - get_binary: Binary was found by /home/runner/.ya/build/build_root/uyxd/001d62/ydb/apps/ydbd/ydbd
2025-12-04 21:00:27,732 - DEBUG - ydb.tests.library.harness.kikimr_runner.625937  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/uyxd/001d62/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:24695', '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-12-04 21:00:27,733 - DEBUG - ya.test.625937  - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-12-04 21:00:27,734 - DEBUG - ya.test.625937  - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-12-04 21:00:27,734 - DEBUG - ya.test.625937  - execute: Executing '['/home/runner/.ya/build/build_root/uyxd/001d62/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:24695', '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-12-04 21:00:27,736 - DEBUG - ya.test.625937  - execute: Command pid: 631985
2025-12-04 21:00:28,544 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631985) rc: 0
2025-12-04 21:00:28,544 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631985) elapsed time (sec): 0.8068118095397949
2025-12-04 21:00:28,545 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631985) idrss: 0
2025-12-04 21:00:28,545 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631985) inblock: 0
2025-12-04 21:00:28,545 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631985) isrss: 0
2025-12-04 21:00:28,546 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631985) ixrss: 0
2025-12-04 21:00:28,546 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631985) majflt: 0
2025-12-04 21:00:28,546 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631985) maxrss: 578772
2025-12-04 21:00:28,546 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631985) minflt: 51974
2025-12-04 21:00:28,547 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631985) msgrcv: 0
2025-12-04 21:00:28,547 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631985) msgsnd: 0
2025-12-04 21:00:28,548 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631985) nivcsw: 71
2025-12-04 21:00:28,548 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631985) nsignals: 0
2025-12-04 21:00:28,548 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631985) nswap: 0
2025-12-04 21:00:28,548 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631985) nvcsw: 612
2025-12-04 21:00:28,549 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631985) oublock: 8
2025-12-04 21:00:28,549 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631985) stime: 0.25792699999999996
2025-12-04 21:00:28,549 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631985) utime: 0.496023
2025-12-04 21:00:28,550 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631985) wtime: 0.809
2025-12-04 21:00:28,550 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631985) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-12-04 21:00:28,550 - DEBUG - ya.test.625937  - _save_outputs: Command (pid 631985) errors:

2025-12-04 21:00:28,551 - INFO - ydb.tests.library.harness.kikimr_runner.625937  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-12-04 21:00:28,713 - INFO - ydb.tests.library.harness.kikimr_runner.625937  - __run: Cluster started and initialized
2025-12-04 21:00:28,746 - DEBUG - ydb.connection.625937  - 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-12-04 21:00:28,750 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.625937  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:00:28,753 - DEBUG - ydb.connection.625937  - 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-12-04 21:00:28,769 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.625937  - context_resolve: Resolving endpoints for database /Root
2025-12-04 21:00:28,770 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ListEndpoints, 67b9d87c-8ced-44ed-816b-af37b3e85979, localhost:24695): creating call state
2025-12-04 21:00:28,771 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ListEndpoints, 67b9d87c-8ced-44ed-816b-af37b3e85979, localhost:24695): request = { database: "/Root" }
2025-12-04 21:00:28,778 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ListEndpoints, 67b9d87c-8ced-44ed-816b-af37b3e85979, localhost:24695): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-fryxcz52gi.auto.internal" port: 24695 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-12-04 21:00:28,779 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.625937  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-fryxcz52gi.auto.internal:24695, location 1, ssl: False>]>
2025-12-04 21:00:28,780 - DEBUG - ydb.connection.625937  - 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-12-04 21:00:28,793 - DEBUG - ydb.connection.625937  - close: Closing channel for endpoint localhost:24695
2025-12-04 21:00:28,794 - DEBUG - ydb.query.pool.625937  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:00:28,796 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(CreateSession, 85430c7a-fa9c-4ecb-a39e-9dd84e797cc2, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:28,796 - DEBUG - ydb.connection.625937  - _log_request: RpcState(CreateSession, 85430c7a-fa9c-4ecb-a39e-9dd84e797cc2, ghrun-fryxcz52gi.auto.internal:24695): request = {  }
2025-12-04 21:00:28,803 - DEBUG - ydb.connection.625937  - _log_response: RpcState(CreateSession, 85430c7a-fa9c-4ecb-a39e-9dd84e797cc2, ghrun-fryxcz52gi.auto.internal:24695): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" node_id: 1 }
2025-12-04 21:00:28,804 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(AttachSession, b424d0e5-ecd0-474c-a978-5bf32cac97b0, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:28,804 - DEBUG - ydb.connection.625937  - _log_request: RpcState(AttachSession, b424d0e5-ecd0-474c-a978-5bf32cac97b0, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" }
2025-12-04 21:00:28,806 - DEBUG - ydb.connection.625937  - _log_response: RpcState(AttachSession, b424d0e5-ecd0-474c-a978-5bf32cac97b0, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:28,808 - DEBUG - ydb.query.pool.625937  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:28,809 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 3642d771-01c2-4e9a-835f-bafe6f763d53, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:28,810 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 3642d771-01c2-4e9a-835f-bafe6f763d53, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:28,811 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 3642d771-01c2-4e9a-835f-bafe6f763d53, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:30,848 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:30,849 - INFO - __tests__.alter_compression.625937  - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-12-04 21:00:30,849 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:30,850 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 8eb98ada-8b94-4e1a-82d4-87c8eb55bd6a, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:30,851 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 8eb98ada-8b94-4e1a-82d4-87c8eb55bd6a, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:30,852 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 8eb98ada-8b94-4e1a-82d4-87c8eb55bd6a, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:31,687 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:31,688 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:31,689 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, a295f642-f082-42bc-80c8-6a3bac252421, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:31,690 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, a295f642-f082-42bc-80c8-6a3bac252421, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:31,691 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, a295f642-f082-42bc-80c8-6a3bac252421, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:32,585 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:32,586 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:32,587 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 26384f06-1723-4fb3-9cdb-ed702fa113ab, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:32,587 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 26384f06-1723-4fb3-9cdb-ed702fa113ab, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:32,589 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 26384f06-1723-4fb3-9cdb-ed702fa113ab, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:33,248 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:33,249 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:33,250 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 62107082-f32b-4bf6-9ff4-9acda02c5ed4, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:33,251 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 62107082-f32b-4bf6-9ff4-9acda02c5ed4, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:33,256 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 62107082-f32b-4bf6-9ff4-9acda02c5ed4, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:34,494 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:34,496 - INFO - __tests__.alter_compression.625937  - 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-12-04 21:00:34,496 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:34,497 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 82614186-5134-497a-b6e9-4b19603382c9, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:34,498 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 82614186-5134-497a-b6e9-4b19603382c9, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:34,500 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 82614186-5134-497a-b6e9-4b19603382c9, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:35,291 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:35,292 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:35,292 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 70aaf0ff-f643-473c-a1bb-3a7c89cc1887, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:35,293 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 70aaf0ff-f643-473c-a1bb-3a7c89cc1887, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:35,296 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 70aaf0ff-f643-473c-a1bb-3a7c89cc1887, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:35,469 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:35,470 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:35,470 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 196e2281-e7f1-4980-a023-71417dc243d2, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:35,471 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 196e2281-e7f1-4980-a023-71417dc243d2, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:35,474 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 196e2281-e7f1-4980-a023-71417dc243d2, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:35,755 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:35,756 - INFO - __tests__.alter_compression.625937  - 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-12-04 21:00:35,756 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:35,757 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, aad9fa7e-c72f-4544-8239-7fdc564491fd, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:35,758 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, aad9fa7e-c72f-4544-8239-7fdc564491fd, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:35,776 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, aad9fa7e-c72f-4544-8239-7fdc564491fd, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:36,625 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:36,626 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:36,626 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, fc2863a0-efae-44ce-ad54-fee40c115fb0, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:36,627 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, fc2863a0-efae-44ce-ad54-fee40c115fb0, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:36,629 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, fc2863a0-efae-44ce-ad54-fee40c115fb0, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:36,845 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:36,846 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:36,847 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, c17e0d80-517d-4662-9443-81d899f2161d, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:36,848 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, c17e0d80-517d-4662-9443-81d899f2161d, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:36,849 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, c17e0d80-517d-4662-9443-81d899f2161d, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:37,131 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:37,132 - INFO - __tests__.alter_compression.625937  - 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-12-04 21:00:37,133 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:37,133 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 02ad5fe4-1550-4f1b-8de8-c14782e16fb7, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:37,134 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 02ad5fe4-1550-4f1b-8de8-c14782e16fb7, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:37,135 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 02ad5fe4-1550-4f1b-8de8-c14782e16fb7, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:37,992 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:37,993 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:37,993 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, d0a86150-8c8c-42d8-84ac-577504f7a9ab, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:37,994 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, d0a86150-8c8c-42d8-84ac-577504f7a9ab, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:37,995 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, d0a86150-8c8c-42d8-84ac-577504f7a9ab, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:38,212 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:38,213 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:38,213 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 6b3473c3-3a7e-4920-bee6-ab8a36114909, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:38,214 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 6b3473c3-3a7e-4920-bee6-ab8a36114909, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:38,216 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 6b3473c3-3a7e-4920-bee6-ab8a36114909, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:38,523 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:38,523 - INFO - __tests__.alter_compression.625937  - 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-12-04 21:00:38,524 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:38,524 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 67541d67-46ce-45c0-ade1-f37edc22e5b4, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:38,525 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 67541d67-46ce-45c0-ade1-f37edc22e5b4, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:38,527 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 67541d67-46ce-45c0-ade1-f37edc22e5b4, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:39,461 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:39,461 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:39,462 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, ba7f6fd5-5d25-444a-90f4-f62d7f4a2689, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:39,463 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, ba7f6fd5-5d25-444a-90f4-f62d7f4a2689, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:39,464 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, ba7f6fd5-5d25-444a-90f4-f62d7f4a2689, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:39,637 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:39,637 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:39,638 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 990a987b-b7e3-4e44-8325-d561b5582a1c, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:39,639 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 990a987b-b7e3-4e44-8325-d561b5582a1c, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:39,641 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 990a987b-b7e3-4e44-8325-d561b5582a1c, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:39,988 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:39,989 - INFO - __tests__.alter_compression.625937  - 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-12-04 21:00:39,989 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:39,990 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, b91c6d21-d680-488a-add7-21eeaaed51e5, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:39,991 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, b91c6d21-d680-488a-add7-21eeaaed51e5, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:39,993 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, b91c6d21-d680-488a-add7-21eeaaed51e5, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:40,872 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:40,873 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:40,874 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 41b0c994-fd93-42a4-bcf6-fa1a06ed28e0, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:40,875 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 41b0c994-fd93-42a4-bcf6-fa1a06ed28e0, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:40,877 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 41b0c994-fd93-42a4-bcf6-fa1a06ed28e0, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:41,104 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:41,105 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:41,106 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, dec941ad-01d2-4f1f-9304-a2f16d660e88, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:41,107 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, dec941ad-01d2-4f1f-9304-a2f16d660e88, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:41,109 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, dec941ad-01d2-4f1f-9304-a2f16d660e88, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:41,479 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:41,479 - INFO - __tests__.alter_compression.625937  - 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-12-04 21:00:41,480 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:41,481 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 55794ece-c255-4a94-83df-5084ede53a72, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:41,481 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 55794ece-c255-4a94-83df-5084ede53a72, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:41,483 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 55794ece-c255-4a94-83df-5084ede53a72, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:42,381 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:42,382 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:42,382 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 50f14f81-c528-4720-a8c1-51981254aa24, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:42,383 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 50f14f81-c528-4720-a8c1-51981254aa24, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:42,384 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 50f14f81-c528-4720-a8c1-51981254aa24, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:42,596 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:42,597 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:42,597 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 94e7376b-b0de-45a2-9bd8-e4423d9a971e, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:42,598 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 94e7376b-b0de-45a2-9bd8-e4423d9a971e, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:42,600 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 94e7376b-b0de-45a2-9bd8-e4423d9a971e, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:43,017 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:43,018 - INFO - __tests__.alter_compression.625937  - 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-12-04 21:00:43,019 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:43,019 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 34783c0d-e041-4249-b51a-45938ef00c15, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:43,020 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 34783c0d-e041-4249-b51a-45938ef00c15, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:43,022 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 34783c0d-e041-4249-b51a-45938ef00c15, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:43,919 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:43,920 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:43,921 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, f312bbc5-cf09-49bb-83cc-b1b9ef15f312, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:43,922 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, f312bbc5-cf09-49bb-83cc-b1b9ef15f312, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:43,923 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, f312bbc5-cf09-49bb-83cc-b1b9ef15f312, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:44,116 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:44,121 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:44,122 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 42b25258-6d52-4922-8cd3-904675a82447, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:44,123 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 42b25258-6d52-4922-8cd3-904675a82447, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:44,124 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 42b25258-6d52-4922-8cd3-904675a82447, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:44,661 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:44,662 - INFO - __tests__.alter_compression.625937  - 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-12-04 21:00:44,663 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:44,663 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 6d3af8ec-1279-4c49-954f-68025f4ae864, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:44,664 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 6d3af8ec-1279-4c49-954f-68025f4ae864, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:44,666 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 6d3af8ec-1279-4c49-954f-68025f4ae864, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:45,574 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:45,575 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:45,575 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 781997ce-3480-41c6-b0b8-3157e0ec3fc0, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:45,576 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 781997ce-3480-41c6-b0b8-3157e0ec3fc0, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:45,578 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 781997ce-3480-41c6-b0b8-3157e0ec3fc0, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:45,777 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:45,778 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:45,779 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 1270ef9b-c37e-4597-9b4e-7fd3793745da, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:45,779 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 1270ef9b-c37e-4597-9b4e-7fd3793745da, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:45,780 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 1270ef9b-c37e-4597-9b4e-7fd3793745da, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:46,308 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:46,309 - INFO - __tests__.alter_compression.625937  - 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-12-04 21:00:46,309 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:46,310 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 932563b8-6f2c-4ab1-926f-7d12823fc85c, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:46,311 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 932563b8-6f2c-4ab1-926f-7d12823fc85c, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:46,312 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 932563b8-6f2c-4ab1-926f-7d12823fc85c, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:47,146 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:47,147 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:47,148 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 85265235-21e4-4d4d-8f56-fb41eada4ec3, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:47,149 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 85265235-21e4-4d4d-8f56-fb41eada4ec3, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:47,150 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 85265235-21e4-4d4d-8f56-fb41eada4ec3, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:47,347 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:47,348 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:47,348 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, bbffad4a-2ce9-42de-b714-6be097b9bc50, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:47,349 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, bbffad4a-2ce9-42de-b714-6be097b9bc50, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:47,351 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, bbffad4a-2ce9-42de-b714-6be097b9bc50, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:47,879 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:47,879 - INFO - __tests__.alter_compression.625937  - 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-12-04 21:00:47,880 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:47,881 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, c5ec3778-aabc-470a-bd1a-3f4fd59ec208, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:47,882 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, c5ec3778-aabc-470a-bd1a-3f4fd59ec208, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:47,883 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, c5ec3778-aabc-470a-bd1a-3f4fd59ec208, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:48,824 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:48,825 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:48,826 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 204edf92-5dfe-4520-bbd8-62f2be2cd610, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:48,855 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 204edf92-5dfe-4520-bbd8-62f2be2cd610, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:48,857 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 204edf92-5dfe-4520-bbd8-62f2be2cd610, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:49,079 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:49,080 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:49,081 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 40b32db7-ceb7-4f0d-be9a-2ab43ecffd45, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:49,081 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 40b32db7-ceb7-4f0d-be9a-2ab43ecffd45, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:49,085 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 40b32db7-ceb7-4f0d-be9a-2ab43ecffd45, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:49,292 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:49,292 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:00:49,293 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, cd795963-0aba-4729-aa19-cc54c09bd61d, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:00:49,293 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, cd795963-0aba-4729-aa19-cc54c09bd61d, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:00:49,294 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, cd795963-0aba-4729-aa19-cc54c09bd61d, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:00:52,782 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:02,824 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:02,824 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, ea6ab9b1-8516-476c-90ac-08242c345259, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:02,825 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, ea6ab9b1-8516-476c-90ac-08242c345259, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:02,827 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, ea6ab9b1-8516-476c-90ac-08242c345259, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:05,903 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:05,953 - INFO - root.625937  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-12-04 21:01:05,954 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:05,954 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 7c538ced-b361-4889-a902-550802a052c9, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:05,955 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 7c538ced-b361-4889-a902-550802a052c9, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:05,956 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 7c538ced-b361-4889-a902-550802a052c9, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:08,565 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:18,604 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:18,605 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, e23e2082-3b91-4c69-b4db-77f8d69c51d0, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:18,606 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, e23e2082-3b91-4c69-b4db-77f8d69c51d0, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:18,607 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, e23e2082-3b91-4c69-b4db-77f8d69c51d0, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:22,018 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:22,129 - INFO - root.625937  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-12-04 21:01:22,130 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:22,131 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 57da94de-98fe-4a8e-8080-46982f30a0f1, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:22,132 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 57da94de-98fe-4a8e-8080-46982f30a0f1, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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 schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:22,133 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 57da94de-98fe-4a8e-8080-46982f30a0f1, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:22,506 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:22,509 - INFO - ya.test.625937  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_4_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 4])
2025-12-04 21:01:22,510 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:22,511 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 52c59949-6268-488e-8ab1-ce696929e5b3, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:22,512 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 52c59949-6268-488e-8ab1-ce696929e5b3, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_4_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 4)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:22,514 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 52c59949-6268-488e-8ab1-ce696929e5b3, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:25,732 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:25,733 - INFO - __tests__.alter_compression.625937  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_4_compression created
2025-12-04 21:01:25,733 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:25,734 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 438f4184-ded0-4bf1-a696-0389d4868a5e, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:25,735 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 438f4184-ded0-4bf1-a696-0389d4868a5e, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_4_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:25,736 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 438f4184-ded0-4bf1-a696-0389d4868a5e, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:26,685 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:26,686 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:26,686 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 5f2f86b4-e2df-4234-aa7d-b6bb7d5ee200, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:26,687 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 5f2f86b4-e2df-4234-aa7d-b6bb7d5ee200, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:26,689 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 5f2f86b4-e2df-4234-aa7d-b6bb7d5ee200, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:28,133 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:28,133 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:28,134 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 899d6487-58c2-4eb0-868e-3880140f39be, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:28,135 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 899d6487-58c2-4eb0-868e-3880140f39be, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:28,136 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 899d6487-58c2-4eb0-868e-3880140f39be, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:29,072 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:29,073 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:29,074 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 05773b4d-db2b-4a62-be5d-6c19f7d6f020, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:29,075 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 05773b4d-db2b-4a62-be5d-6c19f7d6f020, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:29,076 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 05773b4d-db2b-4a62-be5d-6c19f7d6f020, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:31,665 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:31,666 - INFO - __tests__.alter_compression.625937  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318960, 'BlobCount': 128}}
2025-12-04 21:01:31,666 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:31,667 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 89c2f959-1955-405f-856b-dd7a5a4f228a, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:31,668 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 89c2f959-1955-405f-856b-dd7a5a4f228a, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:31,669 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 89c2f959-1955-405f-856b-dd7a5a4f228a, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:33,520 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:33,521 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:33,521 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 16522e1a-f627-4953-8743-23aa28884a72, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:33,522 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 16522e1a-f627-4953-8743-23aa28884a72, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:33,525 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 16522e1a-f627-4953-8743-23aa28884a72, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:33,860 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:33,861 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:33,862 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 0726ecf8-d1b7-47ad-b2f2-9d9908ecda22, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:33,863 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 0726ecf8-d1b7-47ad-b2f2-9d9908ecda22, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:33,864 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 0726ecf8-d1b7-47ad-b2f2-9d9908ecda22, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:34,381 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:34,381 - INFO - __tests__.alter_compression.625937  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 638256, 'BlobCount': 256}}
2025-12-04 21:01:34,382 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:34,383 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 5adb4d07-0418-434d-bbd4-5710b4d687fd, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:34,384 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 5adb4d07-0418-434d-bbd4-5710b4d687fd, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:34,389 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 5adb4d07-0418-434d-bbd4-5710b4d687fd, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:35,856 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:35,857 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:35,857 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, d7322f35-4104-4e99-b2ee-eae129101fa3, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:35,858 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, d7322f35-4104-4e99-b2ee-eae129101fa3, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:35,860 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, d7322f35-4104-4e99-b2ee-eae129101fa3, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:36,227 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:36,228 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:36,228 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 047e9e03-e7bd-4f11-9b62-81d8eac69b7c, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:36,229 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 047e9e03-e7bd-4f11-9b62-81d8eac69b7c, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:36,232 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 047e9e03-e7bd-4f11-9b62-81d8eac69b7c, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:36,800 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:36,801 - INFO - __tests__.alter_compression.625937  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 957296, 'BlobCount': 384}}
2025-12-04 21:01:36,802 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:36,802 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 07e87574-7de7-4e57-bbfa-b27dc2cb7ac2, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:36,803 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 07e87574-7de7-4e57-bbfa-b27dc2cb7ac2, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:36,804 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 07e87574-7de7-4e57-bbfa-b27dc2cb7ac2, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:38,012 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:38,012 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:38,013 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 1962d82a-66ac-4648-a5d1-ca9b2402747d, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:38,013 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 1962d82a-66ac-4648-a5d1-ca9b2402747d, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:38,014 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 1962d82a-66ac-4648-a5d1-ca9b2402747d, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:38,345 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:38,346 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:38,347 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, a2cbd195-7f31-43d1-bd1c-0fc8d3700435, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:38,348 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, a2cbd195-7f31-43d1-bd1c-0fc8d3700435, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:38,349 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, a2cbd195-7f31-43d1-bd1c-0fc8d3700435, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:38,978 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:38,979 - INFO - __tests__.alter_compression.625937  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1276656, 'BlobCount': 512}}
2025-12-04 21:01:38,980 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:38,980 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, d9293dfa-0a62-4925-a409-8dc84d07016d, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:38,981 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, d9293dfa-0a62-4925-a409-8dc84d07016d, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:38,985 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, d9293dfa-0a62-4925-a409-8dc84d07016d, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:39,962 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:39,963 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:39,963 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, baf5d37c-921a-4c22-b68f-91dc304fc689, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:39,964 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, baf5d37c-921a-4c22-b68f-91dc304fc689, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:39,965 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, baf5d37c-921a-4c22-b68f-91dc304fc689, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:40,181 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:40,181 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:40,182 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 78ae750c-1e84-4b96-ae42-7d608de2d6e9, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:40,183 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 78ae750c-1e84-4b96-ae42-7d608de2d6e9, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:40,184 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 78ae750c-1e84-4b96-ae42-7d608de2d6e9, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:40,619 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:40,619 - INFO - __tests__.alter_compression.625937  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1595616, 'BlobCount': 640}}
2025-12-04 21:01:40,619 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:40,620 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, e68b28f6-5f59-41fe-ab2e-5edec9b850d3, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:40,621 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, e68b28f6-5f59-41fe-ab2e-5edec9b850d3, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:40,622 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, e68b28f6-5f59-41fe-ab2e-5edec9b850d3, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:41,612 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:41,613 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:41,614 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, aeb3cbd9-a308-4052-93b6-84953ba34c5b, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:41,614 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, aeb3cbd9-a308-4052-93b6-84953ba34c5b, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:41,616 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, aeb3cbd9-a308-4052-93b6-84953ba34c5b, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:41,853 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:41,854 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:41,855 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, b09f60d9-5e79-4a92-9e1a-9b5226e25fb9, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:41,856 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, b09f60d9-5e79-4a92-9e1a-9b5226e25fb9, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:41,857 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, b09f60d9-5e79-4a92-9e1a-9b5226e25fb9, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:42,364 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:42,365 - INFO - __tests__.alter_compression.625937  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1914800, 'BlobCount': 768}}
2025-12-04 21:01:42,365 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:42,366 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 4293c870-eefe-432d-b98b-2ef879bd5762, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:42,367 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 4293c870-eefe-432d-b98b-2ef879bd5762, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:42,369 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 4293c870-eefe-432d-b98b-2ef879bd5762, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:43,481 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:43,482 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:43,482 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, fbb3ec1a-a0ad-4c50-a56d-383c5219801e, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:43,483 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, fbb3ec1a-a0ad-4c50-a56d-383c5219801e, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:43,484 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, fbb3ec1a-a0ad-4c50-a56d-383c5219801e, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:43,800 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:43,801 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:43,802 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, ff5df2c9-945d-42fc-9a2f-e59db1f89b70, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:43,803 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, ff5df2c9-945d-42fc-9a2f-e59db1f89b70, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:43,804 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, ff5df2c9-945d-42fc-9a2f-e59db1f89b70, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:44,375 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:44,376 - INFO - __tests__.alter_compression.625937  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2233936, 'BlobCount': 896}}
2025-12-04 21:01:44,377 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:44,377 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, ed04a8d3-4a1c-4f21-877b-b477924bee4a, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:44,378 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, ed04a8d3-4a1c-4f21-877b-b477924bee4a, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:44,382 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, ed04a8d3-4a1c-4f21-877b-b477924bee4a, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:45,571 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:45,571 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:45,572 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, eb402260-824b-4ac8-9302-3b3bb67026fb, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:45,573 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, eb402260-824b-4ac8-9302-3b3bb67026fb, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:45,574 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, eb402260-824b-4ac8-9302-3b3bb67026fb, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:45,889 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:45,890 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:45,891 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, f819008c-51db-4496-892b-a5a371b49b7e, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:45,892 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, f819008c-51db-4496-892b-a5a371b49b7e, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:45,893 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, f819008c-51db-4496-892b-a5a371b49b7e, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:46,554 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:46,555 - INFO - __tests__.alter_compression.625937  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2553424, 'BlobCount': 1024}}
2025-12-04 21:01:46,556 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:46,556 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 5fc18872-2b56-413f-a014-b727a887affc, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:46,557 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 5fc18872-2b56-413f-a014-b727a887affc, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:46,559 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 5fc18872-2b56-413f-a014-b727a887affc, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:47,176 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.625937  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:01:47,176 - DEBUG - ydb.connection.625937  - 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-12-04 21:01:47,188 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.625937  - context_resolve: Resolving endpoints for database /Root
2025-12-04 21:01:47,189 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ListEndpoints, decff6c9-04c8-47ff-bc66-cfaca03a6a35, localhost:24695): creating call state
2025-12-04 21:01:47,189 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ListEndpoints, decff6c9-04c8-47ff-bc66-cfaca03a6a35, localhost:24695): request = { database: "/Root" }
2025-12-04 21:01:47,194 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ListEndpoints, decff6c9-04c8-47ff-bc66-cfaca03a6a35, localhost:24695): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-fryxcz52gi.auto.internal" port: 24695 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-12-04 21:01:47,196 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.625937  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-fryxcz52gi.auto.internal:24695, location 1, ssl: False>]>
2025-12-04 21:01:47,196 - DEBUG - ydb.connection.625937  - close: Closing channel for endpoint localhost:24695
2025-12-04 21:01:47,713 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:47,714 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:47,714 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 29947a9f-3f25-4b5c-ad96-74efe0facb99, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:47,715 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 29947a9f-3f25-4b5c-ad96-74efe0facb99, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:47,718 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 29947a9f-3f25-4b5c-ad96-74efe0facb99, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:48,003 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:48,004 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:48,007 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 81c8b4e8-2b51-4bdb-a8e5-4551f3ef73bb, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:48,008 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 81c8b4e8-2b51-4bdb-a8e5-4551f3ef73bb, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:48,009 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 81c8b4e8-2b51-4bdb-a8e5-4551f3ef73bb, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:48,653 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:48,654 - INFO - __tests__.alter_compression.625937  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2872432, 'BlobCount': 1152}}
2025-12-04 21:01:48,654 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:48,655 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 8ade6ca1-3f4a-47c0-91f9-687da5a13c7a, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:48,656 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 8ade6ca1-3f4a-47c0-91f9-687da5a13c7a, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:48,658 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 8ade6ca1-3f4a-47c0-91f9-687da5a13c7a, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:49,765 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:49,766 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:49,767 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, a8196127-dfd1-4123-a978-eed6a09c78eb, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:49,768 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, a8196127-dfd1-4123-a978-eed6a09c78eb, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:49,769 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, a8196127-dfd1-4123-a978-eed6a09c78eb, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:50,015 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:50,016 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:50,017 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 0151d4b3-a479-4525-804a-614dbde4b02b, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:50,018 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 0151d4b3-a479-4525-804a-614dbde4b02b, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:50,020 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 0151d4b3-a479-4525-804a-614dbde4b02b, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:50,705 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:50,706 - INFO - __tests__.alter_compression.625937  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_4_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3191936, 'BlobCount': 1280}}
2025-12-04 21:01:50,706 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:50,707 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 434ece83-24ed-4ec1-93f9-da55ddcf88fd, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:50,707 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 434ece83-24ed-4ec1-93f9-da55ddcf88fd, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_4_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:50,709 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 434ece83-24ed-4ec1-93f9-da55ddcf88fd, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:51,857 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:51,857 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:51,858 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, e8417500-2171-4206-b29f-124969cf2c99, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:51,859 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, e8417500-2171-4206-b29f-124969cf2c99, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:51,861 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, e8417500-2171-4206-b29f-124969cf2c99, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:52,129 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:52,130 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:52,130 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 0d37ac24-972e-4371-9465-ef314dffedfb, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:52,131 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 0d37ac24-972e-4371-9465-ef314dffedfb, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:52,132 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 0d37ac24-972e-4371-9465-ef314dffedfb, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:52,408 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:52,409 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:01:52,409 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 0a93427a-7477-426b-82bb-cbecd3d1f337, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:01:52,410 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 0a93427a-7477-426b-82bb-cbecd3d1f337, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:01:52,416 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 0a93427a-7477-426b-82bb-cbecd3d1f337, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:01:56,062 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:02:06,098 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:02:06,099 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, e12cd826-267e-497e-93b8-2df41bea2176, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:02:06,100 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, e12cd826-267e-497e-93b8-2df41bea2176, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:02:06,101 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, e12cd826-267e-497e-93b8-2df41bea2176, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:02:09,500 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:02:09,558 - INFO - root.625937  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_4_compression`, volumes `value` (8000000, 1595968)
2025-12-04 21:02:09,558 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:02:09,559 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 62913481-06a1-4678-aa52-6d3df3637bb9, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:02:09,560 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 62913481-06a1-4678-aa52-6d3df3637bb9, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" 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_4_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:02:09,563 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 62913481-06a1-4678-aa52-6d3df3637bb9, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:02:10,002 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:02:10,003 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:02:10,004 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 2736e6cf-3cfb-492f-bda3-ad6b18fadc96, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:02:10,005 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 2736e6cf-3cfb-492f-bda3-ad6b18fadc96, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:02:10,006 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 2736e6cf-3cfb-492f-bda3-ad6b18fadc96, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:02:13,368 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:02:23,403 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:02:23,404 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 96fb6159-25dc-4e99-a410-1dc9328e57e7, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:02:23,405 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 96fb6159-25dc-4e99-a410-1dc9328e57e7, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:02:23,406 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 96fb6159-25dc-4e99-a410-1dc9328e57e7, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:02:27,261 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:02:37,320 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:02:37,321 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 4ebfe789-229d-4b9a-bfd3-51c7c53dd2c6, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:02:37,322 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 4ebfe789-229d-4b9a-bfd3-51c7c53dd2c6, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:02:37,323 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 4ebfe789-229d-4b9a-bfd3-51c7c53dd2c6, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:02:39,709 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:02:49,719 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:02:49,720 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 34c767f1-4489-45a3-90da-6782efbd925c, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:02:49,721 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 34c767f1-4489-45a3-90da-6782efbd925c, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:02:49,722 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 34c767f1-4489-45a3-90da-6782efbd925c, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:02:51,197 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:03:01,202 - DEBUG - ydb.query.pool.625937  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:03:01,203 - DEBUG - ydb.connection.625937  - _prepare_call: RpcState(ExecuteQuery, 1837fc1b-537f-4e13-807a-7d43d609951b, ghrun-fryxcz52gi.auto.internal:24695): creating call state
2025-12-04 21:03:01,204 - DEBUG - ydb.connection.625937  - _log_request: RpcState(ExecuteQuery, 1837fc1b-537f-4e13-807a-7d43d609951b, ghrun-fryxcz52gi.auto.internal:24695): request = { session_id: "ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_4_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:03:01,206 - DEBUG - ydb.connection.625937  - _log_response: RpcState(ExecuteQuery, 1837fc1b-537f-4e13-807a-7d43d609951b, ghrun-fryxcz52gi.auto.internal:24695): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:02,207 - DEBUG - ydb.query.pool.625937  - release: Session returned to queue: ydb://session/3?node_id=1&id=ODc5Y2VmNzktNjZmY2UyOWYtZTIxNjliM2EtNjViZmVlN2M=
2025-12-04 21:03:02,212 - INFO - root.625937  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_4_compression`, volumes `value` (8000000, 1466456)
2025-12-04 21:03:02,212 - INFO - root.625937  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_4_compression` 8092160 / 1466456: 5.518174428690666
2025-12-04 21:03:02,214 - INFO - ya.test.625937  - pytest_runtest_teardown: Test teardown
