2025-12-04 21:02:52,331 - INFO - ya.test.704593  - pytest_runtest_setup: ####################################################################################################
2025-12-04 21:02:52,332 - INFO - ya.test.704593  - pytest_runtest_setup: test_all_supported_compression[zstd_6_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 6]
2025-12-04 21:02:52,332 - INFO - ya.test.704593  - pytest_runtest_setup: ####################################################################################################
2025-12-04 21:02:52,333 - INFO - ya.test.704593  - pytest_runtest_setup: Test setup
2025-12-04 21:02:52,335 - DEBUG - ya.test.704593  - _get_command_output_file: Command out will be placed to ydbd.out
2025-12-04 21:02:52,337 - DEBUG - ya.test.704593  - _get_command_output_file: Command err will be placed to ydbd.err
2025-12-04 21:02:52,337 - DEBUG - ya.test.704593  - execute: Executing '['/home/runner/.ya/build/build_root/uyxd/001a1b/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-04 21:02:52,348 - DEBUG - ya.test.704593  - execute: Command pid: 706651
2025-12-04 21:02:53,419 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 706651) rc: 0
2025-12-04 21:02:53,420 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 706651) elapsed time (sec): 1.069762945175171
2025-12-04 21:02:53,420 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 706651) idrss: 0
2025-12-04 21:02:53,420 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 706651) inblock: 0
2025-12-04 21:02:53,421 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 706651) isrss: 0
2025-12-04 21:02:53,421 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 706651) ixrss: 0
2025-12-04 21:02:53,421 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 706651) majflt: 0
2025-12-04 21:02:53,421 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 706651) maxrss: 489976
2025-12-04 21:02:53,422 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 706651) minflt: 45639
2025-12-04 21:02:53,422 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 706651) msgrcv: 0
2025-12-04 21:02:53,422 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 706651) msgsnd: 0
2025-12-04 21:02:53,423 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 706651) nivcsw: 222
2025-12-04 21:02:53,423 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 706651) nsignals: 0
2025-12-04 21:02:53,428 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 706651) nswap: 0
2025-12-04 21:02:53,428 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 706651) nvcsw: 14
2025-12-04 21:02:53,428 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 706651) oublock: 8
2025-12-04 21:02:53,429 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 706651) stime: 0.219267
2025-12-04 21:02:53,429 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 706651) utime: 0.5046269999999999
2025-12-04 21:02:53,429 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 706651) wtime: 1.081
2025-12-04 21:02:53,430 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 706651) 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:02:53,430 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 706651) errors:

2025-12-04 21:02:53,430 - INFO - __tests__.base.704593  - _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:02:53,651 - DEBUG - ya.test.704593  - get_binary: Binary was found by /home/runner/.ya/build/build_root/uyxd/001a1b/ydb/apps/ydbd/ydbd
2025-12-04 21:02:53,653 - DEBUG - library.python.filelock.704593  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/13308
2025-12-04 21:02:53,656 - DEBUG - ydb.tests.library.harness.kikimr_runner.704593  - start: Working directory: /home/runner/.ya/build/build_root/uyxd/001a1b/r3tmp/kikimr_cluster_d7e269y7
2025-12-04 21:02:53,704 - DEBUG - ya.test.704593  - get_binary: Binary was found by /home/runner/.ya/build/build_root/uyxd/001a1b/ydb/apps/ydbd/ydbd
2025-12-04 21:02:53,705 - DEBUG - library.python.filelock.704593  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/16860
2025-12-04 21:02:53,706 - DEBUG - library.python.filelock.704593  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/21948
2025-12-04 21:02:53,707 - DEBUG - library.python.filelock.704593  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/15600
2025-12-04 21:02:53,707 - DEBUG - library.python.filelock.704593  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/23856
2025-12-04 21:02:53,709 - INFO - ydb.tests.library.harness.kikimr_runner.704593  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/uyxd/001a1b/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_6_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.6/cluster/kikimr_configs"
2025-12-04 21:02:53,709 - INFO - ydb.tests.library.harness.kikimr_runner.704593  - __make_run_command: Final command: /home/runner/.ya/build/build_root/uyxd/001a1b/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/001a1b/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_6_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.6/cluster/node_1/logfile_h099odh7.log --grpc-port=16860 --mon-port=21948 --ic-port=13308
2025-12-04 21:02:53,710 - DEBUG - ydb.tests.library.harness.kikimr_runner.704593  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:16860/1, disk_size 68719476736
2025-12-04 21:02:53,710 - INFO - ydb.tests.library.harness.kikimr_runner.704593  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/uyxd/001a1b/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_6_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.6/cluster/kikimr_configs"
2025-12-04 21:02:53,710 - INFO - ydb.tests.library.harness.kikimr_runner.704593  - __make_run_command: Final command: /home/runner/.ya/build/build_root/uyxd/001a1b/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/001a1b/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_6_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.6/cluster/node_1/logfile_h099odh7.log --grpc-port=16860 --mon-port=21948 --ic-port=13308
2025-12-04 21:02:53,714 - DEBUG - ya.test.704593  - execute: Executing '('/home/runner/.ya/build/build_root/uyxd/001a1b/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/uyxd/001a1b/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_6_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.6/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/uyxd/001a1b/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_6_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.6/cluster/node_1/logfile_h099odh7.log', '--grpc-port=16860', '--mon-port=21948', '--ic-port=13308')' in '/home/runner/.ya/build/build_root/uyxd/001a1b/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_6_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.6/cluster/node_1' (no wait)
2025-12-04 21:02:53,720 - DEBUG - ya.test.704593  - execute: Command pid: 707057
2025-12-04 21:02:53,721 - INFO - ydb.tests.library.harness.kikimr_runner.704593  - start: Started node localhost:16860/1
2025-12-04 21:02:53,723 - DEBUG - ya.test.704593  - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-12-04 21:02:53,724 - DEBUG - ya.test.704593  - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-12-04 21:02:53,725 - DEBUG - ya.test.704593  - execute: Executing '['/home/runner/.ya/build/build_root/uyxd/001a1b/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-04 21:02:53,735 - DEBUG - ya.test.704593  - execute: Command pid: 707059
2025-12-04 21:02:54,887 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 707059) rc: 0
2025-12-04 21:02:54,888 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 707059) elapsed time (sec): 1.1508722305297852
2025-12-04 21:02:54,888 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 707059) idrss: 0
2025-12-04 21:02:54,889 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 707059) inblock: 0
2025-12-04 21:02:54,889 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 707059) isrss: 0
2025-12-04 21:02:54,889 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 707059) ixrss: 0
2025-12-04 21:02:54,890 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 707059) majflt: 0
2025-12-04 21:02:54,890 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 707059) maxrss: 501288
2025-12-04 21:02:54,890 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 707059) minflt: 45672
2025-12-04 21:02:54,890 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 707059) msgrcv: 0
2025-12-04 21:02:54,891 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 707059) msgsnd: 0
2025-12-04 21:02:54,891 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 707059) nivcsw: 181
2025-12-04 21:02:54,891 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 707059) nsignals: 0
2025-12-04 21:02:54,896 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 707059) nswap: 0
2025-12-04 21:02:54,897 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 707059) nvcsw: 14
2025-12-04 21:02:54,897 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 707059) oublock: 8
2025-12-04 21:02:54,897 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 707059) stime: 0.227579
2025-12-04 21:02:54,898 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 707059) utime: 0.507218
2025-12-04 21:02:54,898 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 707059) wtime: 1.162
2025-12-04 21:02:54,898 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 707059) 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:02:54,899 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 707059) errors:

2025-12-04 21:02:54,899 - INFO - ydb.tests.library.harness.kikimr_runner.704593  - 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:03:01,185 - DEBUG - ya.test.704593  - get_binary: Binary was found by /home/runner/.ya/build/build_root/uyxd/001a1b/ydb/apps/ydbd/ydbd
2025-12-04 21:03:01,185 - DEBUG - ydb.tests.library.harness.kikimr_runner.704593  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/uyxd/001a1b/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:16860', '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: 13308\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-12-04 21:03:01,187 - DEBUG - ya.test.704593  - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-12-04 21:03:01,188 - DEBUG - ya.test.704593  - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-12-04 21:03:01,188 - DEBUG - ya.test.704593  - execute: Executing '['/home/runner/.ya/build/build_root/uyxd/001a1b/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:16860', '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: 13308\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-12-04 21:03:01,195 - DEBUG - ya.test.704593  - execute: Command pid: 709384
2025-12-04 21:03:02,544 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709384) rc: 0
2025-12-04 21:03:02,545 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709384) elapsed time (sec): 1.3488578796386719
2025-12-04 21:03:02,545 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709384) idrss: 0
2025-12-04 21:03:02,546 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709384) inblock: 0
2025-12-04 21:03:02,546 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709384) isrss: 0
2025-12-04 21:03:02,546 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709384) ixrss: 0
2025-12-04 21:03:02,546 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709384) majflt: 0
2025-12-04 21:03:02,547 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709384) maxrss: 595796
2025-12-04 21:03:02,547 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709384) minflt: 52070
2025-12-04 21:03:02,547 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709384) msgrcv: 0
2025-12-04 21:03:02,548 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709384) msgsnd: 0
2025-12-04 21:03:02,548 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709384) nivcsw: 259
2025-12-04 21:03:02,548 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709384) nsignals: 0
2025-12-04 21:03:02,549 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709384) nswap: 0
2025-12-04 21:03:02,549 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709384) nvcsw: 421
2025-12-04 21:03:02,549 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709384) oublock: 8
2025-12-04 21:03:02,549 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709384) stime: 0.302877
2025-12-04 21:03:02,550 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709384) utime: 0.570485
2025-12-04 21:03:02,550 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709384) wtime: 1.355
2025-12-04 21:03:02,550 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709384) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-12-04 21:03:02,551 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709384) errors:

2025-12-04 21:03:02,554 - DEBUG - ya.test.704593  - get_binary: Binary was found by /home/runner/.ya/build/build_root/uyxd/001a1b/ydb/apps/ydbd/ydbd
2025-12-04 21:03:02,554 - DEBUG - ydb.tests.library.harness.kikimr_runner.704593  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/uyxd/001a1b/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:16860', '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:03:02,556 - DEBUG - ya.test.704593  - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-12-04 21:03:02,557 - DEBUG - ya.test.704593  - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-12-04 21:03:02,557 - DEBUG - ya.test.704593  - execute: Executing '['/home/runner/.ya/build/build_root/uyxd/001a1b/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:16860', '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:03:02,578 - DEBUG - ya.test.704593  - execute: Command pid: 709804
2025-12-04 21:03:03,924 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709804) rc: 0
2025-12-04 21:03:03,924 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709804) elapsed time (sec): 1.3450400829315186
2025-12-04 21:03:03,925 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709804) idrss: 0
2025-12-04 21:03:03,925 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709804) inblock: 0
2025-12-04 21:03:03,925 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709804) isrss: 0
2025-12-04 21:03:03,925 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709804) ixrss: 0
2025-12-04 21:03:03,926 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709804) majflt: 0
2025-12-04 21:03:03,926 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709804) maxrss: 595960
2025-12-04 21:03:03,926 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709804) minflt: 52193
2025-12-04 21:03:03,926 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709804) msgrcv: 0
2025-12-04 21:03:03,927 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709804) msgsnd: 0
2025-12-04 21:03:03,927 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709804) nivcsw: 260
2025-12-04 21:03:03,927 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709804) nsignals: 0
2025-12-04 21:03:03,927 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709804) nswap: 0
2025-12-04 21:03:03,928 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709804) nvcsw: 553
2025-12-04 21:03:03,928 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709804) oublock: 8
2025-12-04 21:03:03,929 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709804) stime: 0.269484
2025-12-04 21:03:03,929 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709804) utime: 0.56119
2025-12-04 21:03:03,929 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709804) wtime: 1.366
2025-12-04 21:03:03,929 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709804) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-12-04 21:03:03,930 - DEBUG - ya.test.704593  - _save_outputs: Command (pid 709804) errors:

2025-12-04 21:03:03,930 - INFO - ydb.tests.library.harness.kikimr_runner.704593  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-12-04 21:03:04,164 - INFO - ydb.tests.library.harness.kikimr_runner.704593  - __run: Cluster started and initialized
2025-12-04 21:03:04,270 - DEBUG - ydb.connection.704593  - 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:03:04,284 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.704593  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:03:04,284 - DEBUG - ydb.connection.704593  - 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:03:04,331 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.704593  - context_resolve: Resolving endpoints for database /Root
2025-12-04 21:03:04,332 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ListEndpoints, df6e060d-ab5c-4295-a3f4-51fbf0d6f76e, localhost:16860): creating call state
2025-12-04 21:03:04,333 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ListEndpoints, df6e060d-ab5c-4295-a3f4-51fbf0d6f76e, localhost:16860): request = { database: "/Root" }
2025-12-04 21:03:04,346 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ListEndpoints, df6e060d-ab5c-4295-a3f4-51fbf0d6f76e, localhost:16860): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-fryxcz52gi.auto.internal" port: 16860 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:03:04,347 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.704593  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-fryxcz52gi.auto.internal:16860, location 1, ssl: False>]>
2025-12-04 21:03:04,349 - DEBUG - ydb.connection.704593  - 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:03:04,382 - DEBUG - ydb.connection.704593  - close: Closing channel for endpoint localhost:16860
2025-12-04 21:03:04,383 - DEBUG - ydb.query.pool.704593  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-04 21:03:04,384 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(CreateSession, 0c94ebc6-b89a-4f62-a650-250aad41dafb, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:04,385 - DEBUG - ydb.connection.704593  - _log_request: RpcState(CreateSession, 0c94ebc6-b89a-4f62-a650-250aad41dafb, ghrun-fryxcz52gi.auto.internal:16860): request = {  }
2025-12-04 21:03:04,396 - DEBUG - ydb.connection.704593  - _log_response: RpcState(CreateSession, 0c94ebc6-b89a-4f62-a650-250aad41dafb, ghrun-fryxcz52gi.auto.internal:16860): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" node_id: 1 }
2025-12-04 21:03:04,397 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(AttachSession, 70aa4e4e-3ccf-4f9f-9ad8-f8c3930a4a05, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:04,398 - DEBUG - ydb.connection.704593  - _log_request: RpcState(AttachSession, 70aa4e4e-3ccf-4f9f-9ad8-f8c3930a4a05, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" }
2025-12-04 21:03:04,412 - DEBUG - ydb.connection.704593  - _log_response: RpcState(AttachSession, 70aa4e4e-3ccf-4f9f-9ad8-f8c3930a4a05, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:04,452 - DEBUG - ydb.query.pool.704593  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:04,453 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, f4f24116-4956-4458-b70d-3cd5bd4ba6b8, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:04,454 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, f4f24116-4956-4458-b70d-3cd5bd4ba6b8, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:04,455 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, f4f24116-4956-4458-b70d-3cd5bd4ba6b8, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:08,603 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:08,604 - INFO - __tests__.alter_compression.704593  - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-12-04 21:03:08,605 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:08,606 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, ea8930ab-3dca-4ec0-90dc-0e3655a32779, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:08,607 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, ea8930ab-3dca-4ec0-90dc-0e3655a32779, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:08,608 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, ea8930ab-3dca-4ec0-90dc-0e3655a32779, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:09,948 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:09,949 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:09,949 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 07db93c3-4db2-418c-8bf4-7579f3580d36, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:09,950 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 07db93c3-4db2-418c-8bf4-7579f3580d36, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:09,953 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 07db93c3-4db2-418c-8bf4-7579f3580d36, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:11,333 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:11,334 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:11,335 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, b9660b22-e9ce-4ec6-8b58-078aa4c60172, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:11,335 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, b9660b22-e9ce-4ec6-8b58-078aa4c60172, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:11,337 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, b9660b22-e9ce-4ec6-8b58-078aa4c60172, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:12,997 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:12,998 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:12,999 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, ef1a8203-1e7c-45c0-9f0f-3c921081c62c, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:13,000 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, ef1a8203-1e7c-45c0-9f0f-3c921081c62c, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:13,003 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, ef1a8203-1e7c-45c0-9f0f-3c921081c62c, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:14,896 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:14,896 - INFO - __tests__.alter_compression.704593  - 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:03:14,897 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:14,898 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 8121d750-401b-4cdc-a6d4-c76a0af489a3, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:14,899 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 8121d750-401b-4cdc-a6d4-c76a0af489a3, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:14,901 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 8121d750-401b-4cdc-a6d4-c76a0af489a3, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:16,223 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:16,223 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:16,224 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 124c991a-3cb1-4f51-bd8b-49516228fcfd, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:16,225 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 124c991a-3cb1-4f51-bd8b-49516228fcfd, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:16,226 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 124c991a-3cb1-4f51-bd8b-49516228fcfd, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:16,754 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:16,755 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:16,755 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 9e76364d-cca3-47a0-b64c-0af02ea7468e, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:16,756 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 9e76364d-cca3-47a0-b64c-0af02ea7468e, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:16,757 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 9e76364d-cca3-47a0-b64c-0af02ea7468e, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:17,433 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:17,433 - INFO - __tests__.alter_compression.704593  - 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:03:17,434 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:17,434 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 2d3bee8f-9a5c-4a4f-9629-23efb58f1e24, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:17,435 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 2d3bee8f-9a5c-4a4f-9629-23efb58f1e24, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:17,436 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 2d3bee8f-9a5c-4a4f-9629-23efb58f1e24, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:18,793 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:18,793 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:18,794 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, f90a9ccd-c631-4fe3-80a4-300de7891e5a, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:18,795 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, f90a9ccd-c631-4fe3-80a4-300de7891e5a, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:18,797 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, f90a9ccd-c631-4fe3-80a4-300de7891e5a, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:19,453 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:19,454 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:19,455 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, dea73166-aa10-4b37-99b4-33d03e35a97d, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:19,456 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, dea73166-aa10-4b37-99b4-33d03e35a97d, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:19,457 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, dea73166-aa10-4b37-99b4-33d03e35a97d, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:20,269 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:20,270 - INFO - __tests__.alter_compression.704593  - 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:03:20,271 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:20,271 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 3eef783b-4b10-482a-af52-2ed9977476ff, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:20,273 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 3eef783b-4b10-482a-af52-2ed9977476ff, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:20,274 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 3eef783b-4b10-482a-af52-2ed9977476ff, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:21,589 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:21,590 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:21,591 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 8ba995d1-bde0-427e-ad40-abd490220bb3, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:21,591 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 8ba995d1-bde0-427e-ad40-abd490220bb3, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:21,593 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 8ba995d1-bde0-427e-ad40-abd490220bb3, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:22,000 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:22,001 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:22,001 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 36fb0ad3-5777-46b5-af5d-c68c238425bc, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:22,002 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 36fb0ad3-5777-46b5-af5d-c68c238425bc, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:22,006 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 36fb0ad3-5777-46b5-af5d-c68c238425bc, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:22,477 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:22,477 - INFO - __tests__.alter_compression.704593  - 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:03:22,478 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:22,479 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 58936dd1-f308-4661-81a6-6dcf6e0f7e13, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:22,480 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 58936dd1-f308-4661-81a6-6dcf6e0f7e13, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:22,481 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 58936dd1-f308-4661-81a6-6dcf6e0f7e13, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:23,920 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:23,921 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:23,922 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 89a602ca-2a95-4882-a733-d17135be7b0c, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:23,922 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 89a602ca-2a95-4882-a733-d17135be7b0c, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:23,927 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 89a602ca-2a95-4882-a733-d17135be7b0c, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:24,287 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:24,288 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:24,288 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 9f66354d-f39c-4222-94fb-5e74e4825e7a, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:24,289 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 9f66354d-f39c-4222-94fb-5e74e4825e7a, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:24,296 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 9f66354d-f39c-4222-94fb-5e74e4825e7a, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:24,909 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:24,910 - INFO - __tests__.alter_compression.704593  - 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:03:24,911 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:24,912 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, e026b0eb-62d1-4bc2-883f-06b5ded02575, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:24,912 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, e026b0eb-62d1-4bc2-883f-06b5ded02575, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:24,918 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, e026b0eb-62d1-4bc2-883f-06b5ded02575, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:26,278 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:26,278 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:26,279 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, ac9c8916-b8c8-42af-850b-8e2dc669f673, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:26,280 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, ac9c8916-b8c8-42af-850b-8e2dc669f673, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:26,282 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, ac9c8916-b8c8-42af-850b-8e2dc669f673, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:26,842 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:26,843 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:26,844 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, d8c804dd-be51-4dfd-8253-88a4f3445622, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:26,844 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, d8c804dd-be51-4dfd-8253-88a4f3445622, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:26,861 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, d8c804dd-be51-4dfd-8253-88a4f3445622, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:27,756 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:27,757 - INFO - __tests__.alter_compression.704593  - 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:03:27,757 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:27,758 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 73d93e12-107f-434b-92b3-1bffd71da091, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:27,762 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 73d93e12-107f-434b-92b3-1bffd71da091, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:27,764 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 73d93e12-107f-434b-92b3-1bffd71da091, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:29,628 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:29,629 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:29,630 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 2a114a7e-1c99-4c6a-abd2-0883859c27cc, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:29,631 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 2a114a7e-1c99-4c6a-abd2-0883859c27cc, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:29,632 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 2a114a7e-1c99-4c6a-abd2-0883859c27cc, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:30,268 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:30,269 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:30,270 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, ebecb3fa-f24f-4ef0-9526-32f7028e87b3, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:30,270 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, ebecb3fa-f24f-4ef0-9526-32f7028e87b3, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:30,274 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, ebecb3fa-f24f-4ef0-9526-32f7028e87b3, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:31,534 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:31,535 - INFO - __tests__.alter_compression.704593  - 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:03:31,535 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:31,536 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, db2710c9-e12d-445e-9f16-9473d0a9ecff, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:31,537 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, db2710c9-e12d-445e-9f16-9473d0a9ecff, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:31,552 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, db2710c9-e12d-445e-9f16-9473d0a9ecff, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:33,353 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:33,354 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:33,355 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, af870ca5-8cc3-4681-a1f6-34d654bfcb40, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:33,356 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, af870ca5-8cc3-4681-a1f6-34d654bfcb40, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:33,357 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, af870ca5-8cc3-4681-a1f6-34d654bfcb40, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:34,271 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:34,272 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:34,273 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, fb801c49-ec4b-4036-ad5a-3461a820cfad, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:34,274 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, fb801c49-ec4b-4036-ad5a-3461a820cfad, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:34,279 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, fb801c49-ec4b-4036-ad5a-3461a820cfad, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:35,323 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:35,323 - INFO - __tests__.alter_compression.704593  - 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:03:35,324 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:35,325 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, dc2cbf29-b92a-4331-9ca0-3541f3dd3ba5, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:35,325 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, dc2cbf29-b92a-4331-9ca0-3541f3dd3ba5, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:35,333 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, dc2cbf29-b92a-4331-9ca0-3541f3dd3ba5, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:36,755 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:36,756 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:36,756 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 74ad8dc9-12d5-4538-89c5-ac0c6842ee00, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:36,757 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 74ad8dc9-12d5-4538-89c5-ac0c6842ee00, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:36,759 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 74ad8dc9-12d5-4538-89c5-ac0c6842ee00, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:37,166 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:37,167 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:37,167 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 828692b3-7ba3-4212-9131-bf69ea5a7116, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:37,168 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 828692b3-7ba3-4212-9131-bf69ea5a7116, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:37,173 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 828692b3-7ba3-4212-9131-bf69ea5a7116, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:38,369 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:38,370 - INFO - __tests__.alter_compression.704593  - 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:03:38,370 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:38,371 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 7f7dde5c-d997-40eb-a618-6a993135e8d7, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:38,372 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 7f7dde5c-d997-40eb-a618-6a993135e8d7, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:38,373 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 7f7dde5c-d997-40eb-a618-6a993135e8d7, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:39,764 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:39,765 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:39,766 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, c64da883-14e0-4e08-b45a-e6d311a85609, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:39,767 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, c64da883-14e0-4e08-b45a-e6d311a85609, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:39,797 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, c64da883-14e0-4e08-b45a-e6d311a85609, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:40,084 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:40,085 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:40,086 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 69947aa7-6b50-4de2-89aa-c83a8d67520b, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:40,087 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 69947aa7-6b50-4de2-89aa-c83a8d67520b, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:40,088 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 69947aa7-6b50-4de2-89aa-c83a8d67520b, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:41,358 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:41,359 - INFO - __tests__.alter_compression.704593  - 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:03:41,359 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:41,360 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 25875eae-7cde-459c-a61c-466ff498490f, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:41,361 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 25875eae-7cde-459c-a61c-466ff498490f, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:41,364 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 25875eae-7cde-459c-a61c-466ff498490f, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:42,842 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:42,843 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:42,844 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 2238a8b8-e4fc-4855-a875-4818dafb2fe1, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:42,845 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 2238a8b8-e4fc-4855-a875-4818dafb2fe1, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:42,847 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 2238a8b8-e4fc-4855-a875-4818dafb2fe1, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:43,196 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:43,197 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:43,198 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, b6d21d9b-5302-406e-a881-d496d961b701, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:43,198 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, b6d21d9b-5302-406e-a881-d496d961b701, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:43,200 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, b6d21d9b-5302-406e-a881-d496d961b701, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:43,647 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:43,648 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:43,649 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, c210aa00-339f-426b-8ae3-60acb55db31e, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:43,650 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, c210aa00-339f-426b-8ae3-60acb55db31e, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:43,651 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, c210aa00-339f-426b-8ae3-60acb55db31e, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:03:48,919 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:59,011 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:03:59,012 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, b61ddda4-db73-4f0b-b461-41b13e7aa6d1, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:03:59,012 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, b61ddda4-db73-4f0b-b461-41b13e7aa6d1, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:03:59,014 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, b61ddda4-db73-4f0b-b461-41b13e7aa6d1, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:04:03,979 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:04,056 - INFO - root.704593  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-12-04 21:04:04,057 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:04,058 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 94e6bdb2-110e-42cc-815f-09ed8c088569, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:04:04,058 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 94e6bdb2-110e-42cc-815f-09ed8c088569, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:04:04,059 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 94e6bdb2-110e-42cc-815f-09ed8c088569, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:04:08,444 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:18,516 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:18,517 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, adb12318-81e8-4115-86e0-8758af08b068, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:04:18,518 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, adb12318-81e8-4115-86e0-8758af08b068, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:04:18,519 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, adb12318-81e8-4115-86e0-8758af08b068, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:04:19,600 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:29,604 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:29,605 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 65462a7c-f309-45d9-80d7-b49fa9415ec5, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:04:29,606 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 65462a7c-f309-45d9-80d7-b49fa9415ec5, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:04:29,608 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 65462a7c-f309-45d9-80d7-b49fa9415ec5, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:04:30,421 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:40,428 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:40,429 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 68c574f5-dc01-4915-96f5-fa49abf7954b, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:04:40,430 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 68c574f5-dc01-4915-96f5-fa49abf7954b, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:04:40,431 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 68c574f5-dc01-4915-96f5-fa49abf7954b, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:04:41,704 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:41,709 - INFO - root.704593  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8009216)
2025-12-04 21:04:41,710 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:41,711 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, c53b2a05-7193-4446-9e86-9f95af4b5815, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:04:41,713 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, c53b2a05-7193-4446-9e86-9f95af4b5815, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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:04:41,715 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, c53b2a05-7193-4446-9e86-9f95af4b5815, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:04:42,052 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:42,056 - INFO - ya.test.704593  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_6_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 6])
2025-12-04 21:04:42,057 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:42,058 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, b94ffc43-1aac-4231-b432-50ae3022137d, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:04:42,059 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, b94ffc43-1aac-4231-b432-50ae3022137d, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_6_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 6)\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:04:42,060 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, b94ffc43-1aac-4231-b432-50ae3022137d, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:04:45,349 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:45,350 - INFO - __tests__.alter_compression.704593  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_6_compression created
2025-12-04 21:04:45,351 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:45,351 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, f3f75380-79f6-406b-99a6-c5df5fa7c02c, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:04:45,352 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, f3f75380-79f6-406b-99a6-c5df5fa7c02c, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_6_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:04:45,357 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, f3f75380-79f6-406b-99a6-c5df5fa7c02c, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:04:46,379 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:46,380 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:46,381 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 266c869f-59a8-447e-b55c-2cdb3f186d40, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:04:46,382 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 266c869f-59a8-447e-b55c-2cdb3f186d40, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:04:46,383 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 266c869f-59a8-447e-b55c-2cdb3f186d40, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:04:48,090 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:48,091 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:48,092 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 3a60e801-48dc-4478-b911-307de8e2ebed, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:04:48,097 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 3a60e801-48dc-4478-b911-307de8e2ebed, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:04:48,098 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 3a60e801-48dc-4478-b911-307de8e2ebed, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:04:49,372 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:49,373 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:49,373 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, b39a743c-267e-4dc6-9b66-86afd48e3e31, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:04:49,374 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, b39a743c-267e-4dc6-9b66-86afd48e3e31, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:04:49,376 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, b39a743c-267e-4dc6-9b66-86afd48e3e31, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:04:51,584 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:51,595 - INFO - __tests__.alter_compression.704593  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318016, 'BlobCount': 128}}
2025-12-04 21:04:51,596 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:51,596 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 184bde3f-1b84-4db4-9422-4757949c8a43, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:04:51,597 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 184bde3f-1b84-4db4-9422-4757949c8a43, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:04:51,605 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 184bde3f-1b84-4db4-9422-4757949c8a43, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:04:53,109 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:53,110 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:53,118 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 8bc7fc08-1842-4d22-8219-e33d6f4291d3, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:04:53,122 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 8bc7fc08-1842-4d22-8219-e33d6f4291d3, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:04:53,124 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 8bc7fc08-1842-4d22-8219-e33d6f4291d3, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:04:53,555 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:53,560 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:53,561 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 1aa43348-cf61-4c57-bfde-3043af85c9b3, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:04:53,563 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 1aa43348-cf61-4c57-bfde-3043af85c9b3, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:04:53,564 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 1aa43348-cf61-4c57-bfde-3043af85c9b3, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:04:54,000 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:54,001 - INFO - __tests__.alter_compression.704593  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 637312, 'BlobCount': 256}}
2025-12-04 21:04:54,001 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:54,010 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, a416921a-68b3-4c10-942e-87cd01daa444, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:04:54,011 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, a416921a-68b3-4c10-942e-87cd01daa444, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:04:54,013 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, a416921a-68b3-4c10-942e-87cd01daa444, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:04:55,426 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:55,426 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:55,427 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 611ac987-b228-4ca7-8a0b-6694641d7d18, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:04:55,444 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 611ac987-b228-4ca7-8a0b-6694641d7d18, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:04:55,446 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 611ac987-b228-4ca7-8a0b-6694641d7d18, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:04:55,987 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:55,987 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:55,990 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, f9a2d2cf-989f-439f-96cf-e2932209813b, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:04:55,993 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, f9a2d2cf-989f-439f-96cf-e2932209813b, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:04:55,995 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, f9a2d2cf-989f-439f-96cf-e2932209813b, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:04:56,735 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:56,735 - INFO - __tests__.alter_compression.704593  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 956352, 'BlobCount': 384}}
2025-12-04 21:04:56,736 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:56,741 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 105e6dad-46c3-47da-984d-fbfa80cff2c1, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:04:56,748 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 105e6dad-46c3-47da-984d-fbfa80cff2c1, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:04:56,750 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 105e6dad-46c3-47da-984d-fbfa80cff2c1, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:04:58,253 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:58,272 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:58,283 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 52bdd7aa-6b49-4db6-81d4-a745349bc40a, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:04:58,284 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 52bdd7aa-6b49-4db6-81d4-a745349bc40a, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:04:58,297 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 52bdd7aa-6b49-4db6-81d4-a745349bc40a, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:04:58,749 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:58,752 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:58,755 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 735e7d66-3638-4e60-bf31-7585954a538d, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:04:58,756 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 735e7d66-3638-4e60-bf31-7585954a538d, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:04:58,758 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 735e7d66-3638-4e60-bf31-7585954a538d, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:04:59,328 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:59,329 - INFO - __tests__.alter_compression.704593  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1275712, 'BlobCount': 512}}
2025-12-04 21:04:59,329 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:04:59,330 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, e808332d-98b4-45d1-8433-dc51a15b4966, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:04:59,337 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, e808332d-98b4-45d1-8433-dc51a15b4966, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:04:59,339 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, e808332d-98b4-45d1-8433-dc51a15b4966, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:05:00,529 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:00,530 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:00,531 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 08ab6f60-cde0-4296-b575-2971284918bd, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:05:00,532 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 08ab6f60-cde0-4296-b575-2971284918bd, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:05:00,533 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 08ab6f60-cde0-4296-b575-2971284918bd, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:05:00,991 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:00,992 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:00,993 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 9e1ff72d-b755-48d9-8ee8-b31d2c3772e1, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:05:00,994 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 9e1ff72d-b755-48d9-8ee8-b31d2c3772e1, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:05:00,996 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 9e1ff72d-b755-48d9-8ee8-b31d2c3772e1, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:05:01,549 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:01,549 - INFO - __tests__.alter_compression.704593  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1594672, 'BlobCount': 640}}
2025-12-04 21:05:01,550 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:01,551 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 45fdcd18-ea6a-4cd6-b3f4-fd1f6b2461ee, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:05:01,554 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 45fdcd18-ea6a-4cd6-b3f4-fd1f6b2461ee, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:05:01,556 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 45fdcd18-ea6a-4cd6-b3f4-fd1f6b2461ee, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:05:03,256 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:03,257 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:03,258 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, d134d6fa-b0f1-4766-847e-201718766368, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:05:03,259 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, d134d6fa-b0f1-4766-847e-201718766368, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:05:03,284 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, d134d6fa-b0f1-4766-847e-201718766368, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:05:03,767 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:03,768 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:03,769 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 00138006-bfa7-43ba-8c97-52bf052675b9, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:05:03,770 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 00138006-bfa7-43ba-8c97-52bf052675b9, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:05:03,777 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 00138006-bfa7-43ba-8c97-52bf052675b9, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:05:04,219 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.704593  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-04 21:05:04,219 - DEBUG - ydb.connection.704593  - 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:05:04,246 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.704593  - context_resolve: Resolving endpoints for database /Root
2025-12-04 21:05:04,247 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ListEndpoints, de1c80fd-fab9-47d6-a83f-b1ef55f146e7, localhost:16860): creating call state
2025-12-04 21:05:04,247 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ListEndpoints, de1c80fd-fab9-47d6-a83f-b1ef55f146e7, localhost:16860): request = { database: "/Root" }
2025-12-04 21:05:04,354 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ListEndpoints, de1c80fd-fab9-47d6-a83f-b1ef55f146e7, localhost:16860): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-fryxcz52gi.auto.internal" port: 16860 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:05:04,355 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.704593  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-fryxcz52gi.auto.internal:16860, location 1, ssl: False>]>
2025-12-04 21:05:04,356 - DEBUG - ydb.connection.704593  - close: Closing channel for endpoint localhost:16860
2025-12-04 21:05:04,956 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:04,957 - INFO - __tests__.alter_compression.704593  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1913856, 'BlobCount': 768}}
2025-12-04 21:05:04,957 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:04,958 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 072fc868-0d0c-4069-a324-62ff81b565f2, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:05:04,961 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 072fc868-0d0c-4069-a324-62ff81b565f2, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:05:04,962 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 072fc868-0d0c-4069-a324-62ff81b565f2, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:05:06,537 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:06,538 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:06,538 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 091236ef-552b-404e-8917-c2c62484cd22, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:05:06,539 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 091236ef-552b-404e-8917-c2c62484cd22, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:05:06,541 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 091236ef-552b-404e-8917-c2c62484cd22, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:05:06,930 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:06,931 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:06,932 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, aa3836b9-62af-4a09-9da7-74d00e59c9cc, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:05:06,934 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, aa3836b9-62af-4a09-9da7-74d00e59c9cc, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:05:06,936 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, aa3836b9-62af-4a09-9da7-74d00e59c9cc, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:05:07,893 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:07,894 - INFO - __tests__.alter_compression.704593  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2232992, 'BlobCount': 896}}
2025-12-04 21:05:07,894 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:07,895 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 8d0d7cbd-a334-4f8f-8228-59bbf0b345ea, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:05:07,895 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 8d0d7cbd-a334-4f8f-8228-59bbf0b345ea, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:05:07,896 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 8d0d7cbd-a334-4f8f-8228-59bbf0b345ea, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:05:09,572 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:09,573 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:09,580 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 6312c6db-922c-489f-9aaf-37aeb81f287d, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:05:09,581 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 6312c6db-922c-489f-9aaf-37aeb81f287d, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:05:09,582 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 6312c6db-922c-489f-9aaf-37aeb81f287d, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:05:09,956 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:09,964 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:09,965 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, ed2dbd82-2471-4c30-8b36-ea7cae8aea67, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:05:09,966 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, ed2dbd82-2471-4c30-8b36-ea7cae8aea67, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:05:09,976 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, ed2dbd82-2471-4c30-8b36-ea7cae8aea67, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:05:10,736 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:10,736 - INFO - __tests__.alter_compression.704593  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2552480, 'BlobCount': 1024}}
2025-12-04 21:05:10,737 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:10,738 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 93879ba4-64b6-4d31-a64b-7ea1069d9897, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:05:10,738 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 93879ba4-64b6-4d31-a64b-7ea1069d9897, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:05:10,745 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 93879ba4-64b6-4d31-a64b-7ea1069d9897, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:05:12,519 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:12,520 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:12,520 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 7145d391-1946-43c7-9b25-be6e87f0ee52, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:05:12,525 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 7145d391-1946-43c7-9b25-be6e87f0ee52, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:05:12,526 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 7145d391-1946-43c7-9b25-be6e87f0ee52, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:05:12,975 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:12,980 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:12,981 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 41ad5879-0d12-4d59-bd02-c1859786fe3e, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:05:12,982 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 41ad5879-0d12-4d59-bd02-c1859786fe3e, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:05:12,984 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 41ad5879-0d12-4d59-bd02-c1859786fe3e, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:05:14,095 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:14,096 - INFO - __tests__.alter_compression.704593  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2871488, 'BlobCount': 1152}}
2025-12-04 21:05:14,103 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:14,105 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, f2dfd60e-c0f6-4c4c-a29b-9da9e1c71f33, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:05:14,107 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, f2dfd60e-c0f6-4c4c-a29b-9da9e1c71f33, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:05:14,109 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, f2dfd60e-c0f6-4c4c-a29b-9da9e1c71f33, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:05:15,750 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:15,751 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:15,752 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 68ed0249-9294-4c7a-9be0-c5e67d2cd16c, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:05:15,753 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 68ed0249-9294-4c7a-9be0-c5e67d2cd16c, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:05:15,754 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 68ed0249-9294-4c7a-9be0-c5e67d2cd16c, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:05:16,146 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:16,147 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:16,148 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, d2c644ac-7b77-4487-8c88-c8cf0a4fa779, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:05:16,150 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, d2c644ac-7b77-4487-8c88-c8cf0a4fa779, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:05:16,157 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, d2c644ac-7b77-4487-8c88-c8cf0a4fa779, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:05:17,536 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:17,537 - INFO - __tests__.alter_compression.704593  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_6_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3190992, 'BlobCount': 1280}}
2025-12-04 21:05:17,537 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:17,538 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, e3821c56-c75d-43f1-8146-7f3f6d2ca5c3, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:05:17,539 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, e3821c56-c75d-43f1-8146-7f3f6d2ca5c3, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_6_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-04 21:05:17,541 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, e3821c56-c75d-43f1-8146-7f3f6d2ca5c3, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:05:19,271 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:19,271 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:19,272 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 947ec611-88a5-460d-a0c0-72e9656587b8, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:05:19,284 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 947ec611-88a5-460d-a0c0-72e9656587b8, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:05:19,294 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 947ec611-88a5-460d-a0c0-72e9656587b8, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:05:19,689 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:19,689 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:19,690 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 860fa45c-4852-4848-9f2b-8fdb1a3b6aa0, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:05:19,691 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 860fa45c-4852-4848-9f2b-8fdb1a3b6aa0, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:05:19,693 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 860fa45c-4852-4848-9f2b-8fdb1a3b6aa0, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:05:20,148 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:20,149 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:20,150 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 49b958af-da89-491c-bab4-71d572f36daf, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:05:20,151 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 49b958af-da89-491c-bab4-71d572f36daf, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_6_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:05:20,153 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 49b958af-da89-491c-bab4-71d572f36daf, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:05:26,011 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:36,116 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:36,117 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 950c2a06-5d23-4631-8b87-9c1237718325, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:05:36,122 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 950c2a06-5d23-4631-8b87-9c1237718325, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_6_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:05:36,127 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 950c2a06-5d23-4631-8b87-9c1237718325, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:05:40,456 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:40,494 - INFO - root.704593  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_6_compression`, volumes `value` (8000000, 1595496)
2025-12-04 21:05:40,513 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:40,528 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 8ca7c3f6-4c37-48d5-8e33-7de53ee63c72, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:05:40,534 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 8ca7c3f6-4c37-48d5-8e33-7de53ee63c72, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" 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_6_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:05:40,542 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 8ca7c3f6-4c37-48d5-8e33-7de53ee63c72, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:05:40,966 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:40,968 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:40,975 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, bd2be73e-cff5-4480-865c-1ad9ed2b64ad, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:05:40,987 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, bd2be73e-cff5-4480-865c-1ad9ed2b64ad, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_6_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:05:40,991 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, bd2be73e-cff5-4480-865c-1ad9ed2b64ad, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:05:46,772 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:56,841 - DEBUG - ydb.query.pool.704593  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:56,842 - DEBUG - ydb.connection.704593  - _prepare_call: RpcState(ExecuteQuery, 01bc41e2-97b6-402e-84ed-05a168e76a52, ghrun-fryxcz52gi.auto.internal:16860): creating call state
2025-12-04 21:05:56,843 - DEBUG - ydb.connection.704593  - _log_request: RpcState(ExecuteQuery, 01bc41e2-97b6-402e-84ed-05a168e76a52, ghrun-fryxcz52gi.auto.internal:16860): request = { session_id: "ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_6_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:05:56,844 - DEBUG - ydb.connection.704593  - _log_response: RpcState(ExecuteQuery, 01bc41e2-97b6-402e-84ed-05a168e76a52, ghrun-fryxcz52gi.auto.internal:16860): response = { <_MultiThreadedRendezvous object> }
2025-12-04 21:05:59,643 - DEBUG - ydb.query.pool.704593  - release: Session returned to queue: ydb://session/3?node_id=1&id=NzVhNGRmOS1kYzBmYTJiYy0yNzM5NTk4LTdhNTUxOWZh
2025-12-04 21:05:59,666 - INFO - root.704593  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_6_compression`, volumes `value` (8000000, 1484408)
2025-12-04 21:05:59,667 - INFO - root.704593  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_6_compression` 8092160 / 1484408: 5.451439226951081
2025-12-04 21:05:59,678 - INFO - ya.test.704593  - pytest_runtest_teardown: Test teardown
