2025-12-05 16:17:50,399 - INFO - ya.test.22781  - pytest_runtest_setup: ####################################################################################################
2025-12-05 16:17:50,400 - INFO - ya.test.22781  - pytest_runtest_setup: test_all_supported_compression[zstd_15_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 15]
2025-12-05 16:17:50,400 - INFO - ya.test.22781  - pytest_runtest_setup: ####################################################################################################
2025-12-05 16:17:50,400 - INFO - ya.test.22781  - pytest_runtest_setup: Test setup
2025-12-05 16:17:50,434 - DEBUG - ya.test.22781  - _get_command_output_file: Command out will be placed to ydbd.out
2025-12-05 16:17:50,439 - DEBUG - ya.test.22781  - _get_command_output_file: Command err will be placed to ydbd.err
2025-12-05 16:17:50,457 - DEBUG - ya.test.22781  - execute: Executing '['/home/runner/.ya/build/build_root/nihu/0016f6/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-05 16:17:50,517 - DEBUG - ya.test.22781  - execute: Command pid: 23768
2025-12-05 16:17:53,190 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 23768) rc: 0
2025-12-05 16:17:53,190 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 23768) elapsed time (sec): 2.664752960205078
2025-12-05 16:17:53,191 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 23768) idrss: 0
2025-12-05 16:17:53,191 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 23768) inblock: 0
2025-12-05 16:17:53,191 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 23768) isrss: 0
2025-12-05 16:17:53,192 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 23768) ixrss: 0
2025-12-05 16:17:53,192 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 23768) majflt: 0
2025-12-05 16:17:53,192 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 23768) maxrss: 486392
2025-12-05 16:17:53,192 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 23768) minflt: 45713
2025-12-05 16:17:53,193 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 23768) msgrcv: 0
2025-12-05 16:17:53,193 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 23768) msgsnd: 0
2025-12-05 16:17:53,193 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 23768) nivcsw: 267
2025-12-05 16:17:53,194 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 23768) nsignals: 0
2025-12-05 16:17:53,194 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 23768) nswap: 0
2025-12-05 16:17:53,194 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 23768) nvcsw: 14
2025-12-05 16:17:53,194 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 23768) oublock: 8
2025-12-05 16:17:53,195 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 23768) stime: 1.249438
2025-12-05 16:17:53,195 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 23768) utime: 0.460974
2025-12-05 16:17:53,195 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 23768) wtime: 2.725
2025-12-05 16:17:53,196 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 23768) output:
Git info:
    Commit: 7e4a069eed48cd0542e43cfcd8d71021826caed7
    Branch: 
    Author: Pisarenko Grigoriy <grigoriypisar@ydb.tech>
    Summary: Merge a01fb38f4f5fc409f3a42967229b198aa52519b3 into 3022ce6da3be33dce544958fe431efb7eb8af83a
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-a66hhqwkt4    Host information: 
        Linux ghrun-a66hhqwkt4 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-05 16:17:53,196 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 23768) errors:

2025-12-05 16:17:53,196 - INFO - __tests__.base.22781  - _setup_ydb: Git info:
    Commit: 7e4a069eed48cd0542e43cfcd8d71021826caed7
    Branch: 
    Author: Pisarenko Grigoriy <grigoriypisar@ydb.tech>
    Summary: Merge a01fb38f4f5fc409f3a42967229b198aa52519b3 into 3022ce6da3be33dce544958fe431efb7eb8af83a
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-a66hhqwkt4    Host information: 
        Linux ghrun-a66hhqwkt4 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-05 16:17:53,467 - DEBUG - ya.test.22781  - get_binary: Binary was found by /home/runner/.ya/build/build_root/nihu/0016f6/ydb/apps/ydbd/ydbd
2025-12-05 16:17:53,483 - DEBUG - library.python.filelock.22781  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/30554
2025-12-05 16:17:53,523 - DEBUG - ydb.tests.library.harness.kikimr_runner.22781  - start: Working directory: /home/runner/.ya/build/build_root/nihu/0016f6/r3tmp/kikimr_cluster_jz_vw4ej
2025-12-05 16:17:53,628 - DEBUG - ya.test.22781  - get_binary: Binary was found by /home/runner/.ya/build/build_root/nihu/0016f6/ydb/apps/ydbd/ydbd
2025-12-05 16:17:53,637 - DEBUG - library.python.filelock.22781  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/11351
2025-12-05 16:17:53,638 - DEBUG - library.python.filelock.22781  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/24772
2025-12-05 16:17:53,638 - DEBUG - library.python.filelock.22781  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/14160
2025-12-05 16:17:53,639 - DEBUG - library.python.filelock.22781  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/4861
2025-12-05 16:17:53,640 - INFO - ydb.tests.library.harness.kikimr_runner.22781  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/nihu/0016f6/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_15_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.15/cluster/kikimr_configs"
2025-12-05 16:17:53,640 - INFO - ydb.tests.library.harness.kikimr_runner.22781  - __make_run_command: Final command: /home/runner/.ya/build/build_root/nihu/0016f6/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/nihu/0016f6/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_15_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.15/cluster/node_1/logfile_fy1rfs1a.log --grpc-port=11351 --mon-port=24772 --ic-port=30554
2025-12-05 16:17:53,641 - DEBUG - ydb.tests.library.harness.kikimr_runner.22781  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:11351/1, disk_size 68719476736
2025-12-05 16:17:53,641 - INFO - ydb.tests.library.harness.kikimr_runner.22781  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/nihu/0016f6/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_15_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.15/cluster/kikimr_configs"
2025-12-05 16:17:53,642 - INFO - ydb.tests.library.harness.kikimr_runner.22781  - __make_run_command: Final command: /home/runner/.ya/build/build_root/nihu/0016f6/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/nihu/0016f6/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_15_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.15/cluster/node_1/logfile_fy1rfs1a.log --grpc-port=11351 --mon-port=24772 --ic-port=30554
2025-12-05 16:17:53,643 - DEBUG - ya.test.22781  - execute: Executing '('/home/runner/.ya/build/build_root/nihu/0016f6/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/nihu/0016f6/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_15_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.15/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/nihu/0016f6/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_15_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.15/cluster/node_1/logfile_fy1rfs1a.log', '--grpc-port=11351', '--mon-port=24772', '--ic-port=30554')' in '/home/runner/.ya/build/build_root/nihu/0016f6/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk2/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_15_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.15/cluster/node_1' (no wait)
2025-12-05 16:17:53,658 - DEBUG - ya.test.22781  - execute: Command pid: 24084
2025-12-05 16:17:53,659 - INFO - ydb.tests.library.harness.kikimr_runner.22781  - start: Started node localhost:11351/1
2025-12-05 16:17:53,661 - DEBUG - ya.test.22781  - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-12-05 16:17:53,661 - DEBUG - ya.test.22781  - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-12-05 16:17:53,662 - DEBUG - ya.test.22781  - execute: Executing '['/home/runner/.ya/build/build_root/nihu/0016f6/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-05 16:17:53,693 - DEBUG - ya.test.22781  - execute: Command pid: 24086
2025-12-05 16:18:00,248 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 24086) rc: 0
2025-12-05 16:18:00,248 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 24086) elapsed time (sec): 6.552993535995483
2025-12-05 16:18:00,249 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 24086) idrss: 0
2025-12-05 16:18:00,250 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 24086) inblock: 0
2025-12-05 16:18:00,251 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 24086) isrss: 0
2025-12-05 16:18:00,252 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 24086) ixrss: 0
2025-12-05 16:18:00,261 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 24086) majflt: 0
2025-12-05 16:18:00,262 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 24086) maxrss: 488472
2025-12-05 16:18:00,263 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 24086) minflt: 45612
2025-12-05 16:18:00,265 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 24086) msgrcv: 0
2025-12-05 16:18:00,270 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 24086) msgsnd: 0
2025-12-05 16:18:00,271 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 24086) nivcsw: 1060
2025-12-05 16:18:00,277 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 24086) nsignals: 0
2025-12-05 16:18:00,279 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 24086) nswap: 0
2025-12-05 16:18:00,280 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 24086) nvcsw: 14
2025-12-05 16:18:00,287 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 24086) oublock: 8
2025-12-05 16:18:00,289 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 24086) stime: 4.146661
2025-12-05 16:18:00,290 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 24086) utime: 0.49453199999999997
2025-12-05 16:18:00,292 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 24086) wtime: 6.569
2025-12-05 16:18:00,310 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 24086) output:
Git info:
    Commit: 7e4a069eed48cd0542e43cfcd8d71021826caed7
    Branch: 
    Author: Pisarenko Grigoriy <grigoriypisar@ydb.tech>
    Summary: Merge a01fb38f4f5fc409f3a42967229b198aa52519b3 into 3022ce6da3be33dce544958fe431efb7eb8af83a
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-a66hhqwkt4    Host information: 
        Linux ghrun-a66hhqwkt4 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-05 16:18:00,321 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 24086) errors:

2025-12-05 16:18:00,323 - INFO - ydb.tests.library.harness.kikimr_runner.22781  - start: Node 1 version:
Git info:
    Commit: 7e4a069eed48cd0542e43cfcd8d71021826caed7
    Branch: 
    Author: Pisarenko Grigoriy <grigoriypisar@ydb.tech>
    Summary: Merge a01fb38f4f5fc409f3a42967229b198aa52519b3 into 3022ce6da3be33dce544958fe431efb7eb8af83a
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-a66hhqwkt4    Host information: 
        Linux ghrun-a66hhqwkt4 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64
2025-12-05 16:18:25,035 - DEBUG - ya.test.22781  - get_binary: Binary was found by /home/runner/.ya/build/build_root/nihu/0016f6/ydb/apps/ydbd/ydbd
2025-12-05 16:18:25,040 - DEBUG - ydb.tests.library.harness.kikimr_runner.22781  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/nihu/0016f6/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:11351', '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: 30554\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-12-05 16:18:25,042 - DEBUG - ya.test.22781  - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-12-05 16:18:25,042 - DEBUG - ya.test.22781  - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-12-05 16:18:25,043 - DEBUG - ya.test.22781  - execute: Executing '['/home/runner/.ya/build/build_root/nihu/0016f6/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:11351', '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: 30554\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-12-05 16:18:25,046 - DEBUG - ya.test.22781  - execute: Command pid: 27847
2025-12-05 16:18:26,310 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 27847) rc: 0
2025-12-05 16:18:26,310 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 27847) elapsed time (sec): 1.1587953567504883
2025-12-05 16:18:26,311 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 27847) idrss: 0
2025-12-05 16:18:26,311 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 27847) inblock: 0
2025-12-05 16:18:26,311 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 27847) isrss: 0
2025-12-05 16:18:26,311 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 27847) ixrss: 0
2025-12-05 16:18:26,312 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 27847) majflt: 0
2025-12-05 16:18:26,312 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 27847) maxrss: 623536
2025-12-05 16:18:26,312 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 27847) minflt: 52129
2025-12-05 16:18:26,313 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 27847) msgrcv: 0
2025-12-05 16:18:26,313 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 27847) msgsnd: 0
2025-12-05 16:18:26,313 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 27847) nivcsw: 107
2025-12-05 16:18:26,313 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 27847) nsignals: 0
2025-12-05 16:18:26,314 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 27847) nswap: 0
2025-12-05 16:18:26,314 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 27847) nvcsw: 641
2025-12-05 16:18:26,314 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 27847) oublock: 8
2025-12-05 16:18:26,315 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 27847) stime: 0.29622
2025-12-05 16:18:26,315 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 27847) utime: 0.564404
2025-12-05 16:18:26,315 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 27847) wtime: 1.162
2025-12-05 16:18:26,316 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 27847) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-12-05 16:18:26,316 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 27847) errors:

2025-12-05 16:18:26,358 - DEBUG - ya.test.22781  - get_binary: Binary was found by /home/runner/.ya/build/build_root/nihu/0016f6/ydb/apps/ydbd/ydbd
2025-12-05 16:18:26,405 - DEBUG - ydb.tests.library.harness.kikimr_runner.22781  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/nihu/0016f6/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:11351', '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-05 16:18:26,407 - DEBUG - ya.test.22781  - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-12-05 16:18:26,419 - DEBUG - ya.test.22781  - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-12-05 16:18:26,419 - DEBUG - ya.test.22781  - execute: Executing '['/home/runner/.ya/build/build_root/nihu/0016f6/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:11351', '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-05 16:18:26,429 - DEBUG - ya.test.22781  - execute: Command pid: 28632
2025-12-05 16:18:27,961 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 28632) rc: 0
2025-12-05 16:18:27,962 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 28632) elapsed time (sec): 1.4848272800445557
2025-12-05 16:18:27,962 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 28632) idrss: 0
2025-12-05 16:18:27,992 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 28632) inblock: 0
2025-12-05 16:18:27,992 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 28632) isrss: 0
2025-12-05 16:18:27,993 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 28632) ixrss: 0
2025-12-05 16:18:27,995 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 28632) majflt: 0
2025-12-05 16:18:27,995 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 28632) maxrss: 624080
2025-12-05 16:18:27,995 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 28632) minflt: 52105
2025-12-05 16:18:27,996 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 28632) msgrcv: 0
2025-12-05 16:18:27,996 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 28632) msgsnd: 0
2025-12-05 16:18:27,996 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 28632) nivcsw: 232
2025-12-05 16:18:27,996 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 28632) nsignals: 0
2025-12-05 16:18:27,997 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 28632) nswap: 0
2025-12-05 16:18:27,997 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 28632) nvcsw: 311
2025-12-05 16:18:27,997 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 28632) oublock: 8
2025-12-05 16:18:27,997 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 28632) stime: 0.283973
2025-12-05 16:18:27,998 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 28632) utime: 0.6551279999999999
2025-12-05 16:18:27,998 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 28632) wtime: 1.536
2025-12-05 16:18:27,998 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 28632) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-12-05 16:18:27,999 - DEBUG - ya.test.22781  - _save_outputs: Command (pid 28632) errors:

2025-12-05 16:18:28,009 - INFO - ydb.tests.library.harness.kikimr_runner.22781  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-12-05 16:18:28,261 - INFO - ydb.tests.library.harness.kikimr_runner.22781  - __run: Cluster started and initialized
2025-12-05 16:18:28,381 - DEBUG - ydb.connection.22781  - 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-05 16:18:28,407 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.22781  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-05 16:18:28,408 - DEBUG - ydb.connection.22781  - 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-05 16:18:28,440 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.22781  - context_resolve: Resolving endpoints for database /Root
2025-12-05 16:18:28,445 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ListEndpoints, 428e1e21-2d73-40e0-aa9f-364bd83e256e, localhost:11351): creating call state
2025-12-05 16:18:28,458 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ListEndpoints, 428e1e21-2d73-40e0-aa9f-364bd83e256e, localhost:11351): request = { database: "/Root" }
2025-12-05 16:18:28,468 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ListEndpoints, 428e1e21-2d73-40e0-aa9f-364bd83e256e, localhost:11351): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-a66hhqwkt4.auto.internal" port: 11351 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-05 16:18:28,490 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.22781  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-a66hhqwkt4.auto.internal:11351, location 1, ssl: False>]>
2025-12-05 16:18:28,491 - DEBUG - ydb.connection.22781  - 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-05 16:18:28,673 - DEBUG - ydb.connection.22781  - close: Closing channel for endpoint localhost:11351
2025-12-05 16:18:28,674 - DEBUG - ydb.query.pool.22781  - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-12-05 16:18:28,745 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(CreateSession, 33a436b2-d9e8-4187-953b-c51110d74e4a, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:28,757 - DEBUG - ydb.connection.22781  - _log_request: RpcState(CreateSession, 33a436b2-d9e8-4187-953b-c51110d74e4a, ghrun-a66hhqwkt4.auto.internal:11351): request = {  }
2025-12-05 16:18:28,765 - DEBUG - ydb.connection.22781  - _log_response: RpcState(CreateSession, 33a436b2-d9e8-4187-953b-c51110d74e4a, ghrun-a66hhqwkt4.auto.internal:11351): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" node_id: 1 }
2025-12-05 16:18:28,779 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(AttachSession, 954450ee-d58b-4e58-a88d-11cd1213aadb, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:28,780 - DEBUG - ydb.connection.22781  - _log_request: RpcState(AttachSession, 954450ee-d58b-4e58-a88d-11cd1213aadb, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" }
2025-12-05 16:18:28,782 - DEBUG - ydb.connection.22781  - _log_response: RpcState(AttachSession, 954450ee-d58b-4e58-a88d-11cd1213aadb, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:28,792 - DEBUG - ydb.query.pool.22781  - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:28,838 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, f35eacc9-40bb-4bab-b7d6-a679015a4c93, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:28,861 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, f35eacc9-40bb-4bab-b7d6-a679015a4c93, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:18:28,862 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, f35eacc9-40bb-4bab-b7d6-a679015a4c93, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:34,289 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:34,289 - INFO - __tests__.alter_compression.22781  - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-12-05 16:18:34,290 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:34,291 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 7a6f4087-a926-4561-ab95-e70de1f1d2df, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:34,292 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 7a6f4087-a926-4561-ab95-e70de1f1d2df, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:18:34,312 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 7a6f4087-a926-4561-ab95-e70de1f1d2df, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:36,726 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:36,822 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:36,822 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, d3b968e4-75e0-4937-b566-bff9fc72e72c, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:36,823 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, d3b968e4-75e0-4937-b566-bff9fc72e72c, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:18:36,846 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, d3b968e4-75e0-4937-b566-bff9fc72e72c, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:38,743 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:38,745 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:38,746 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 36a088e2-876b-4f7e-a0f1-bcec04ca7b1e, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:38,762 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 36a088e2-876b-4f7e-a0f1-bcec04ca7b1e, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:18:38,763 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 36a088e2-876b-4f7e-a0f1-bcec04ca7b1e, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:39,931 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:39,945 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:40,062 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, a62bb6f6-2959-47ee-b3e7-b32b18800657, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:40,063 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, a62bb6f6-2959-47ee-b3e7-b32b18800657, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:18:40,064 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, a62bb6f6-2959-47ee-b3e7-b32b18800657, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:42,438 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:42,438 - INFO - __tests__.alter_compression.22781  - 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-05 16:18:42,439 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:42,439 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 8dbceefb-02ef-4a1f-b758-179fef5bd62d, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:42,440 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 8dbceefb-02ef-4a1f-b758-179fef5bd62d, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:18:42,446 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 8dbceefb-02ef-4a1f-b758-179fef5bd62d, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:43,366 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:43,367 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:43,385 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 4d7f0ac9-718a-4cc2-bd4d-7bd04d490d3e, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:43,387 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 4d7f0ac9-718a-4cc2-bd4d-7bd04d490d3e, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:18:43,388 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 4d7f0ac9-718a-4cc2-bd4d-7bd04d490d3e, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:43,785 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:43,786 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:43,786 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 1e51e303-9b11-4066-b5dc-a329e6c763d5, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:43,801 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 1e51e303-9b11-4066-b5dc-a329e6c763d5, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:18:43,815 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 1e51e303-9b11-4066-b5dc-a329e6c763d5, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:44,196 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:44,197 - INFO - __tests__.alter_compression.22781  - 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-05 16:18:44,197 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:44,198 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, b15620e9-4b0b-4778-98b9-92b1928b05da, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:44,199 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, b15620e9-4b0b-4778-98b9-92b1928b05da, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:18:44,200 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, b15620e9-4b0b-4778-98b9-92b1928b05da, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:45,328 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:45,329 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:45,330 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 9896593a-dac9-40c3-8972-8a22a27f74d8, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:45,357 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 9896593a-dac9-40c3-8972-8a22a27f74d8, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:18:45,358 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 9896593a-dac9-40c3-8972-8a22a27f74d8, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:45,724 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:45,725 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:45,726 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 31bd7f40-f86f-4d7b-8f29-041051571373, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:45,726 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 31bd7f40-f86f-4d7b-8f29-041051571373, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:18:45,749 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 31bd7f40-f86f-4d7b-8f29-041051571373, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:46,221 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:46,222 - INFO - __tests__.alter_compression.22781  - 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-05 16:18:46,223 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:46,223 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 79991607-256e-4939-a7d1-a2b233850236, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:46,224 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 79991607-256e-4939-a7d1-a2b233850236, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:18:46,226 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 79991607-256e-4939-a7d1-a2b233850236, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:47,044 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:47,045 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:47,046 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, b0f100ea-756a-4bdc-898d-e6dfdd9a771b, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:47,046 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, b0f100ea-756a-4bdc-898d-e6dfdd9a771b, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:18:47,048 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, b0f100ea-756a-4bdc-898d-e6dfdd9a771b, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:47,331 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:47,332 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:47,333 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 82824490-4a8e-48d8-9b00-4e7d0f38f70a, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:47,334 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 82824490-4a8e-48d8-9b00-4e7d0f38f70a, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:18:47,335 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 82824490-4a8e-48d8-9b00-4e7d0f38f70a, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:47,820 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:47,821 - INFO - __tests__.alter_compression.22781  - 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-05 16:18:47,863 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:47,891 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 3fb84042-927b-448e-9db1-9d04db27e2d4, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:47,892 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 3fb84042-927b-448e-9db1-9d04db27e2d4, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:18:47,894 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 3fb84042-927b-448e-9db1-9d04db27e2d4, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:49,206 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:49,382 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:49,382 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 9bd259b2-6db0-40e0-b37d-21665b1b2016, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:49,410 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 9bd259b2-6db0-40e0-b37d-21665b1b2016, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:18:49,411 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 9bd259b2-6db0-40e0-b37d-21665b1b2016, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:50,021 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:50,034 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:50,034 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, f3cd64c3-3d6e-48ea-ab8f-98735997a153, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:50,035 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, f3cd64c3-3d6e-48ea-ab8f-98735997a153, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:18:50,037 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, f3cd64c3-3d6e-48ea-ab8f-98735997a153, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:50,504 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:50,587 - INFO - __tests__.alter_compression.22781  - 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-05 16:18:50,588 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:50,588 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, e91352cd-0ee9-4e1f-8998-f11e7cfafce6, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:50,589 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, e91352cd-0ee9-4e1f-8998-f11e7cfafce6, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:18:50,591 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, e91352cd-0ee9-4e1f-8998-f11e7cfafce6, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:51,543 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:51,543 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:51,544 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 71cf46bf-5ef0-48a9-9246-93c1f58911e6, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:51,566 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 71cf46bf-5ef0-48a9-9246-93c1f58911e6, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:18:51,568 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 71cf46bf-5ef0-48a9-9246-93c1f58911e6, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:51,920 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:51,926 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:51,927 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, e01fa75b-b9a6-4fd6-ac13-2ab5e9b6be6d, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:51,928 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, e01fa75b-b9a6-4fd6-ac13-2ab5e9b6be6d, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:18:51,929 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, e01fa75b-b9a6-4fd6-ac13-2ab5e9b6be6d, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:52,581 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:52,582 - INFO - __tests__.alter_compression.22781  - 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-05 16:18:52,582 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:52,583 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 29d820f7-524c-4883-af24-ae5affb7aa9a, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:52,584 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 29d820f7-524c-4883-af24-ae5affb7aa9a, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:18:52,591 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 29d820f7-524c-4883-af24-ae5affb7aa9a, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:53,737 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:53,738 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:53,739 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 115daa48-344a-484f-a016-6f1ee68193fe, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:53,739 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 115daa48-344a-484f-a016-6f1ee68193fe, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:18:53,741 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 115daa48-344a-484f-a016-6f1ee68193fe, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:54,154 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:54,214 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:54,311 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, afa67c53-af64-4e99-b4ee-d6bfcf7fdcc2, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:54,312 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, afa67c53-af64-4e99-b4ee-d6bfcf7fdcc2, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:18:54,313 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, afa67c53-af64-4e99-b4ee-d6bfcf7fdcc2, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:55,347 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:55,363 - INFO - __tests__.alter_compression.22781  - 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-05 16:18:55,363 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:55,364 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 91ed5152-8c71-47c0-895e-cbbf1d73ac8e, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:55,379 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 91ed5152-8c71-47c0-895e-cbbf1d73ac8e, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:18:55,380 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 91ed5152-8c71-47c0-895e-cbbf1d73ac8e, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:56,608 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:56,627 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:56,628 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, a4e7fe72-9cfa-402b-a25c-edf348da69a5, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:56,629 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, a4e7fe72-9cfa-402b-a25c-edf348da69a5, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:18:56,630 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, a4e7fe72-9cfa-402b-a25c-edf348da69a5, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:56,870 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:56,934 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:56,935 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, f8a15cbd-69af-45e9-ad96-164aac96c467, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:56,938 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, f8a15cbd-69af-45e9-ad96-164aac96c467, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:18:56,939 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, f8a15cbd-69af-45e9-ad96-164aac96c467, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:57,731 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:57,731 - INFO - __tests__.alter_compression.22781  - 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-05 16:18:57,732 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:57,733 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 694e72b3-cecb-408d-b87c-371ef86d92da, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:57,734 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 694e72b3-cecb-408d-b87c-371ef86d92da, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:18:57,735 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 694e72b3-cecb-408d-b87c-371ef86d92da, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:58,864 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:58,865 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:58,932 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 258cff6e-0f48-40b1-b616-1a7b0c20e209, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:58,933 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 258cff6e-0f48-40b1-b616-1a7b0c20e209, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:18:58,934 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 258cff6e-0f48-40b1-b616-1a7b0c20e209, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:59,235 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:59,236 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:18:59,236 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 94c88d22-e514-40f6-b674-303e6659e474, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:18:59,238 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 94c88d22-e514-40f6-b674-303e6659e474, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:18:59,239 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 94c88d22-e514-40f6-b674-303e6659e474, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:18:59,977 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:19:00,090 - INFO - __tests__.alter_compression.22781  - 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-05 16:19:00,091 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:19:00,119 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 942d9107-8d03-4aba-b797-7067f670df51, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:19:00,120 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 942d9107-8d03-4aba-b797-7067f670df51, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:19:00,121 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 942d9107-8d03-4aba-b797-7067f670df51, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:19:01,102 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:19:01,102 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:19:01,103 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, f860e95e-abde-4793-a83f-f7251f36503f, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:19:01,104 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, f860e95e-abde-4793-a83f-f7251f36503f, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:19:01,106 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, f860e95e-abde-4793-a83f-f7251f36503f, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:19:01,354 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:19:01,355 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:19:01,356 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, a270a1e3-f945-483f-a944-8dbeb0499230, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:19:01,356 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, a270a1e3-f945-483f-a944-8dbeb0499230, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:19:01,386 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, a270a1e3-f945-483f-a944-8dbeb0499230, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:19:02,047 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:19:02,048 - INFO - __tests__.alter_compression.22781  - 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-05 16:19:02,049 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:19:02,049 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 4aade6d9-26b8-4c6a-bb01-7d997ed52b5a, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:19:02,050 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 4aade6d9-26b8-4c6a-bb01-7d997ed52b5a, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:19:02,052 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 4aade6d9-26b8-4c6a-bb01-7d997ed52b5a, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:19:03,254 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:19:03,254 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:19:03,255 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, b7bcd7bd-b198-42ad-825e-88d7dd080610, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:19:03,256 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, b7bcd7bd-b198-42ad-825e-88d7dd080610, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:19:03,259 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, b7bcd7bd-b198-42ad-825e-88d7dd080610, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:19:03,762 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:19:03,796 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:19:03,797 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, f49a6fb1-5abd-4411-8025-a0520e8e1996, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:19:03,798 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, f49a6fb1-5abd-4411-8025-a0520e8e1996, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:19:03,799 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, f49a6fb1-5abd-4411-8025-a0520e8e1996, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:19:04,225 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:19:04,237 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:19:04,238 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 3eab4132-a621-42da-afb4-012c45858b2f, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:19:04,239 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 3eab4132-a621-42da-afb4-012c45858b2f, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:19:04,240 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 3eab4132-a621-42da-afb4-012c45858b2f, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:19:08,738 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:19:18,813 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:19:18,814 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 10d68cca-fefa-4e44-9677-3a62fc62ed5a, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:19:18,834 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 10d68cca-fefa-4e44-9677-3a62fc62ed5a, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:19:18,859 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 10d68cca-fefa-4e44-9677-3a62fc62ed5a, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:19:21,852 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:19:21,893 - INFO - root.22781  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-12-05 16:19:21,894 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:19:21,894 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, fc603860-9b7f-468e-8b0f-e85312e85e54, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:19:21,895 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, fc603860-9b7f-468e-8b0f-e85312e85e54, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:19:21,897 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, fc603860-9b7f-468e-8b0f-e85312e85e54, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:19:25,403 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:19:35,445 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:19:35,455 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 249d6f36-2179-4b16-8872-8c10c5139efd, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:19:35,456 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 249d6f36-2179-4b16-8872-8c10c5139efd, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:19:35,458 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 249d6f36-2179-4b16-8872-8c10c5139efd, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:19:37,637 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:19:41,722 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.22781  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-05 16:19:41,752 - DEBUG - ydb.connection.22781  - 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-05 16:19:41,764 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.22781  - context_resolve: Resolving endpoints for database /Root
2025-12-05 16:19:41,801 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ListEndpoints, f21dccbb-5f5f-4c4c-9348-52da6bbf9a28, localhost:11351): creating call state
2025-12-05 16:19:41,802 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ListEndpoints, f21dccbb-5f5f-4c4c-9348-52da6bbf9a28, localhost:11351): request = { database: "/Root" }
2025-12-05 16:19:41,808 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ListEndpoints, f21dccbb-5f5f-4c4c-9348-52da6bbf9a28, localhost:11351): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-a66hhqwkt4.auto.internal" port: 11351 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-05 16:19:41,814 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.22781  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-a66hhqwkt4.auto.internal:11351, location 1, ssl: False>]>
2025-12-05 16:19:41,832 - DEBUG - ydb.connection.22781  - close: Closing channel for endpoint localhost:11351
2025-12-05 16:19:47,697 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:19:47,698 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, cc44b820-9d9b-42e7-a083-fc257eab15c5, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:19:47,699 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, cc44b820-9d9b-42e7-a083-fc257eab15c5, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:19:47,712 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, cc44b820-9d9b-42e7-a083-fc257eab15c5, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:19:48,320 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:19:58,325 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:19:58,342 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 7758e734-f006-4a2a-9b74-26661f1e6f0d, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:19:58,343 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 7758e734-f006-4a2a-9b74-26661f1e6f0d, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:19:58,345 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 7758e734-f006-4a2a-9b74-26661f1e6f0d, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:19:58,962 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:19:58,966 - INFO - root.22781  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8009216)
2025-12-05 16:19:58,975 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:19:58,984 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, e9031799-368a-49f0-a14b-2c8e13e79c10, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:19:58,985 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, e9031799-368a-49f0-a14b-2c8e13e79c10, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" 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-05 16:19:58,987 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, e9031799-368a-49f0-a14b-2c8e13e79c10, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:19:59,252 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:19:59,258 - INFO - ya.test.22781  - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_15_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 15])
2025-12-05 16:19:59,258 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:19:59,259 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, cd25146f-5e06-43e9-9439-29a3ffb3cdf1, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:19:59,260 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, cd25146f-5e06-43e9-9439-29a3ffb3cdf1, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_15_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 15)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:19:59,262 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, cd25146f-5e06-43e9-9439-29a3ffb3cdf1, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:01,824 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:01,848 - INFO - __tests__.alter_compression.22781  - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_15_compression created
2025-12-05 16:20:01,849 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:01,859 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 8f80a808-c17f-4390-8cac-5bdaf694be50, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:01,868 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 8f80a808-c17f-4390-8cac-5bdaf694be50, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_15_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:01,880 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 8f80a808-c17f-4390-8cac-5bdaf694be50, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:02,793 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:02,794 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:02,794 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 6ad5860c-cbbf-43c6-a0a8-7ccfbf833fad, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:02,795 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 6ad5860c-cbbf-43c6-a0a8-7ccfbf833fad, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 0;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:02,797 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 6ad5860c-cbbf-43c6-a0a8-7ccfbf833fad, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:05,612 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:05,612 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:05,613 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, c8112104-2822-432c-9214-f51962f91333, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:05,614 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, c8112104-2822-432c-9214-f51962f91333, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:05,615 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, c8112104-2822-432c-9214-f51962f91333, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:06,440 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:06,441 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:06,443 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 1e57bf0a-da80-4c9c-8d0f-7a24c3c7f638, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:06,453 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 1e57bf0a-da80-4c9c-8d0f-7a24c3c7f638, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:06,467 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 1e57bf0a-da80-4c9c-8d0f-7a24c3c7f638, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:08,014 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:08,014 - INFO - __tests__.alter_compression.22781  - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318544, 'BlobCount': 128}}
2025-12-05 16:20:08,015 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:08,015 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 3ae9906f-35ff-4961-a8b9-d9a12058c4a3, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:08,016 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 3ae9906f-35ff-4961-a8b9-d9a12058c4a3, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 100000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:08,017 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 3ae9906f-35ff-4961-a8b9-d9a12058c4a3, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:10,437 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:10,438 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:10,439 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, f231607a-d4c3-46e0-b2ef-c0b63479dbde, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:10,440 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, f231607a-d4c3-46e0-b2ef-c0b63479dbde, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:10,441 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, f231607a-d4c3-46e0-b2ef-c0b63479dbde, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:10,672 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:10,673 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:10,673 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, a0de26f3-7f04-462e-a882-944e6711af60, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:10,674 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, a0de26f3-7f04-462e-a882-944e6711af60, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:10,676 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, a0de26f3-7f04-462e-a882-944e6711af60, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:10,968 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:10,970 - INFO - __tests__.alter_compression.22781  - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 638064, 'BlobCount': 256}}
2025-12-05 16:20:10,970 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:10,971 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 4e73f136-82a9-4fc9-9eda-34cdb9de6dab, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:10,971 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 4e73f136-82a9-4fc9-9eda-34cdb9de6dab, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 200000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:10,973 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 4e73f136-82a9-4fc9-9eda-34cdb9de6dab, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:13,200 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:13,202 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:13,202 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 8d00a9ac-64bd-422c-95db-69a20d33a8d6, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:13,203 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 8d00a9ac-64bd-422c-95db-69a20d33a8d6, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:13,204 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 8d00a9ac-64bd-422c-95db-69a20d33a8d6, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:13,525 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:13,525 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:13,526 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 36821371-2054-432f-b6e9-4c337b96cbd7, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:13,527 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 36821371-2054-432f-b6e9-4c337b96cbd7, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:13,528 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 36821371-2054-432f-b6e9-4c337b96cbd7, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:13,844 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:13,845 - INFO - __tests__.alter_compression.22781  - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 957088, 'BlobCount': 384}}
2025-12-05 16:20:13,846 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:13,847 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, df484e4d-86a4-4588-8092-6c56a6b20353, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:13,848 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, df484e4d-86a4-4588-8092-6c56a6b20353, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 300000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:13,849 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, df484e4d-86a4-4588-8092-6c56a6b20353, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:16,113 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:16,122 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:16,132 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, d1b73fe3-a5ee-4d38-94d5-cfd55a118552, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:16,142 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, d1b73fe3-a5ee-4d38-94d5-cfd55a118552, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:16,155 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, d1b73fe3-a5ee-4d38-94d5-cfd55a118552, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:16,363 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:16,364 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:16,365 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, e0e62bc9-0ff1-4dc4-9242-042af8d44ab0, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:16,366 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, e0e62bc9-0ff1-4dc4-9242-042af8d44ab0, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:16,425 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, e0e62bc9-0ff1-4dc4-9242-042af8d44ab0, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:16,840 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:16,886 - INFO - __tests__.alter_compression.22781  - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1276560, 'BlobCount': 512}}
2025-12-05 16:20:16,887 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:16,888 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 14e8513d-19b3-436c-ab02-ef2fd68ad6c1, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:16,889 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 14e8513d-19b3-436c-ab02-ef2fd68ad6c1, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 400000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:16,899 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 14e8513d-19b3-436c-ab02-ef2fd68ad6c1, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:19,437 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:19,439 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:19,439 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 36357bcb-cf53-4545-a0fa-659195c0704a, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:19,440 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 36357bcb-cf53-4545-a0fa-659195c0704a, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:19,454 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 36357bcb-cf53-4545-a0fa-659195c0704a, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:19,708 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:19,715 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:19,716 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 7e3b3cf6-b805-4622-97d0-eb6bca45a431, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:19,717 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 7e3b3cf6-b805-4622-97d0-eb6bca45a431, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:19,741 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 7e3b3cf6-b805-4622-97d0-eb6bca45a431, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:20,188 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:20,189 - INFO - __tests__.alter_compression.22781  - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1595584, 'BlobCount': 640}}
2025-12-05 16:20:20,189 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:20,190 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, f1c44b24-5702-4319-80b1-8ce63134a18b, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:20,190 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, f1c44b24-5702-4319-80b1-8ce63134a18b, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 500000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:20,192 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, f1c44b24-5702-4319-80b1-8ce63134a18b, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:22,667 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:22,668 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:22,669 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 1f83fab3-13d9-4655-ae68-3e8e925afd10, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:22,670 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 1f83fab3-13d9-4655-ae68-3e8e925afd10, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:22,671 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 1f83fab3-13d9-4655-ae68-3e8e925afd10, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:22,917 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:22,951 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:22,952 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, c5bfdd84-3fda-40ec-9c6d-c5e874f6abb0, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:22,953 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, c5bfdd84-3fda-40ec-9c6d-c5e874f6abb0, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:22,955 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, c5bfdd84-3fda-40ec-9c6d-c5e874f6abb0, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:23,426 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:23,427 - INFO - __tests__.alter_compression.22781  - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1914960, 'BlobCount': 768}}
2025-12-05 16:20:23,427 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:23,428 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, ed5efcf8-7aab-49cf-81bb-d2dd20f4c863, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:23,429 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, ed5efcf8-7aab-49cf-81bb-d2dd20f4c863, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 600000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:23,434 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, ed5efcf8-7aab-49cf-81bb-d2dd20f4c863, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:25,700 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:25,708 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:25,709 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 7f6a6455-4eee-4430-9cfa-f03024626410, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:25,710 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 7f6a6455-4eee-4430-9cfa-f03024626410, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:25,711 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 7f6a6455-4eee-4430-9cfa-f03024626410, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:25,945 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:25,970 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:25,980 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 743eff8a-189c-4f2d-8953-6fcded8bbd25, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:25,983 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 743eff8a-189c-4f2d-8953-6fcded8bbd25, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:25,984 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 743eff8a-189c-4f2d-8953-6fcded8bbd25, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:26,558 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:26,558 - INFO - __tests__.alter_compression.22781  - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2234080, 'BlobCount': 896}}
2025-12-05 16:20:26,559 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:26,560 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, e1296188-36c5-4296-bb5a-581886ca74bd, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:26,561 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, e1296188-36c5-4296-bb5a-581886ca74bd, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 700000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:26,562 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, e1296188-36c5-4296-bb5a-581886ca74bd, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:28,937 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:28,938 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:28,938 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 7d9cd369-09bb-44ca-a4b1-6988248f023d, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:28,939 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 7d9cd369-09bb-44ca-a4b1-6988248f023d, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:28,941 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 7d9cd369-09bb-44ca-a4b1-6988248f023d, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:29,330 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:29,331 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:29,332 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, d940be20-26e2-47ca-ad45-921c59a6dbdf, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:29,333 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, d940be20-26e2-47ca-ad45-921c59a6dbdf, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:29,334 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, d940be20-26e2-47ca-ad45-921c59a6dbdf, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:30,114 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:30,122 - INFO - __tests__.alter_compression.22781  - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2553696, 'BlobCount': 1024}}
2025-12-05 16:20:30,122 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:30,123 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, b3d7a2c0-567a-4bfa-8e77-e7c5560398fb, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:30,124 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, b3d7a2c0-567a-4bfa-8e77-e7c5560398fb, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 800000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:30,129 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, b3d7a2c0-567a-4bfa-8e77-e7c5560398fb, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:32,934 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:32,935 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:32,936 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 7e05ac12-ae7d-4f9b-aa0a-3ef9bcad5440, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:32,937 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 7e05ac12-ae7d-4f9b-aa0a-3ef9bcad5440, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:32,938 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 7e05ac12-ae7d-4f9b-aa0a-3ef9bcad5440, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:33,301 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:33,315 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:33,316 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, ddfc265f-d2c0-4f10-bc49-2fcdef1409b7, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:33,317 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, ddfc265f-d2c0-4f10-bc49-2fcdef1409b7, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:33,319 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, ddfc265f-d2c0-4f10-bc49-2fcdef1409b7, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:34,107 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:34,107 - INFO - __tests__.alter_compression.22781  - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2872720, 'BlobCount': 1152}}
2025-12-05 16:20:34,108 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:34,109 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, cce929e5-8f6a-45ee-beb8-99884ecbb0da, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:34,110 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, cce929e5-8f6a-45ee-beb8-99884ecbb0da, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 900000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/zstd_15_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:34,111 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, cce929e5-8f6a-45ee-beb8-99884ecbb0da, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:37,954 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:37,955 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:37,956 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 91a2f614-7aeb-46a7-868f-47f0b17b00b4, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:37,957 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 91a2f614-7aeb-46a7-868f-47f0b17b00b4, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:37,958 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 91a2f614-7aeb-46a7-868f-47f0b17b00b4, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:38,455 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:38,465 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:38,465 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, efeb8475-0498-4095-ac05-85b3e4015286, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:38,466 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, efeb8475-0498-4095-ac05-85b3e4015286, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:38,468 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, efeb8475-0498-4095-ac05-85b3e4015286, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:39,607 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:39,607 - INFO - __tests__.alter_compression.22781  - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_15_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3192432, 'BlobCount': 1280}}
2025-12-05 16:20:39,608 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:39,608 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 312c975c-f006-49a4-9d1e-5f29532dfddb, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:39,609 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 312c975c-f006-49a4-9d1e-5f29532dfddb, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_15_compression`" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:39,610 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 312c975c-f006-49a4-9d1e-5f29532dfddb, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:41,838 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:41,839 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:41,840 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, ec8a192f-7c43-4b6c-8ae3-fa94843bbe27, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:41,841 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, ec8a192f-7c43-4b6c-8ae3-fa94843bbe27, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:41,842 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, ec8a192f-7c43-4b6c-8ae3-fa94843bbe27, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:42,298 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:42,299 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:42,299 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 39eccbf9-3382-4799-9ab3-25bd8bb62a88, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:42,300 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 39eccbf9-3382-4799-9ab3-25bd8bb62a88, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:42,306 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 39eccbf9-3382-4799-9ab3-25bd8bb62a88, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:42,800 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:42,806 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:42,807 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, fe931dc2-79d7-468f-898d-042d32e0a0c0, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:42,808 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, fe931dc2-79d7-468f-898d-042d32e0a0c0, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:42,810 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, fe931dc2-79d7-468f-898d-042d32e0a0c0, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:20:46,453 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:55,763 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.22781  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-05 16:20:55,764 - DEBUG - ydb.connection.22781  - 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-05 16:20:55,779 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.22781  - context_resolve: Resolving endpoints for database /Root
2025-12-05 16:20:55,818 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ListEndpoints, 6fec9c3e-1577-4a78-a228-e7560221ec74, localhost:11351): creating call state
2025-12-05 16:20:55,819 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ListEndpoints, 6fec9c3e-1577-4a78-a228-e7560221ec74, localhost:11351): request = { database: "/Root" }
2025-12-05 16:20:55,826 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ListEndpoints, 6fec9c3e-1577-4a78-a228-e7560221ec74, localhost:11351): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-a66hhqwkt4.auto.internal" port: 11351 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-05 16:20:55,827 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.22781  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-a66hhqwkt4.auto.internal:11351, location 1, ssl: False>]>
2025-12-05 16:20:55,828 - DEBUG - ydb.connection.22781  - close: Closing channel for endpoint localhost:11351
2025-12-05 16:20:56,518 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:20:56,519 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 1d7bd19d-4e79-456d-9a31-c4ba2f18f5a9, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:20:56,519 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 1d7bd19d-4e79-456d-9a31-c4ba2f18f5a9, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:20:56,546 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 1d7bd19d-4e79-456d-9a31-c4ba2f18f5a9, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:21:00,730 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:21:00,774 - INFO - root.22781  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_15_compression`, volumes `value` (8000000, 1596216)
2025-12-05 16:21:00,796 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:21:00,797 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, c32f7402-9ac0-45cb-a41a-b393faf7dd73, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:21:00,798 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, c32f7402-9ac0-45cb-a41a-b393faf7dd73, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:21:00,799 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, c32f7402-9ac0-45cb-a41a-b393faf7dd73, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:21:01,188 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:21:01,222 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:21:01,228 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, f333cfb2-dd33-414b-9b14-a393766ee8cd, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:21:01,229 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, f333cfb2-dd33-414b-9b14-a393766ee8cd, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:21:01,230 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, f333cfb2-dd33-414b-9b14-a393766ee8cd, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:21:05,084 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:21:15,117 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:21:15,118 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, 4d30effc-e87e-430b-8541-09baff2a0355, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:21:15,119 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, 4d30effc-e87e-430b-8541-09baff2a0355, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:21:15,120 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, 4d30effc-e87e-430b-8541-09baff2a0355, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:21:16,303 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:21:26,338 - DEBUG - ydb.query.pool.22781  - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:21:26,341 - DEBUG - ydb.connection.22781  - _prepare_call: RpcState(ExecuteQuery, fb18afd5-d7f9-41df-b967-b51bf3e693dd, ghrun-a66hhqwkt4.auto.internal:11351): creating call state
2025-12-05 16:21:26,342 - DEBUG - ydb.connection.22781  - _log_request: RpcState(ExecuteQuery, fb18afd5-d7f9-41df-b967-b51bf3e693dd, ghrun-a66hhqwkt4.auto.internal:11351): request = { session_id: "ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_15_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE schema_inclusion_mode: SCHEMA_INCLUSION_MODE_ALWAYS result_set_format: FORMAT_VALUE }
2025-12-05 16:21:26,344 - DEBUG - ydb.connection.22781  - _log_response: RpcState(ExecuteQuery, fb18afd5-d7f9-41df-b967-b51bf3e693dd, ghrun-a66hhqwkt4.auto.internal:11351): response = { <_MultiThreadedRendezvous object> }
2025-12-05 16:21:26,925 - DEBUG - ydb.query.pool.22781  - release: Session returned to queue: ydb://session/3?node_id=1&id=MzZmODI5MjYtNGRjOGM5MGEtNTJjOTYwZWQtZTlhNTgwZg==
2025-12-05 16:21:26,939 - INFO - root.22781  - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_15_compression`, volumes `value` (8000000, 1870856)
2025-12-05 16:21:26,946 - INFO - root.22781  - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_15_compression` 8092160 / 1870856: 4.325378329491954
2025-12-05 16:21:26,972 - INFO - ya.test.22781  - pytest_runtest_teardown: Test teardown
