2025-11-05 12:37:46,548 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-05 12:37:46,549 - INFO - ya.test - pytest_runtest_setup: test_all_supported_compression[zstd_compression-COMPRESSION = "zstd"]
2025-11-05 12:37:46,549 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-05 12:37:46,549 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-05 12:37:46,552 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-05 12:37:46,552 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-05 12:37:46,553 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/c688/002800/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-05 12:37:46,555 - DEBUG - ya.test - execute: Command pid: 2679761
2025-11-05 12:37:47,357 - DEBUG - ya.test - _save_outputs: Command (pid 2679761) rc: 0
2025-11-05 12:37:47,358 - DEBUG - ya.test - _save_outputs: Command (pid 2679761) elapsed time (sec): 0.8009819984436035
2025-11-05 12:37:47,358 - DEBUG - ya.test - _save_outputs: Command (pid 2679761) idrss: 0
2025-11-05 12:37:47,359 - DEBUG - ya.test - _save_outputs: Command (pid 2679761) inblock: 0
2025-11-05 12:37:47,359 - DEBUG - ya.test - _save_outputs: Command (pid 2679761) isrss: 0
2025-11-05 12:37:47,359 - DEBUG - ya.test - _save_outputs: Command (pid 2679761) ixrss: 0
2025-11-05 12:37:47,360 - DEBUG - ya.test - _save_outputs: Command (pid 2679761) majflt: 0
2025-11-05 12:37:47,360 - DEBUG - ya.test - _save_outputs: Command (pid 2679761) maxrss: 492716
2025-11-05 12:37:47,361 - DEBUG - ya.test - _save_outputs: Command (pid 2679761) minflt: 45309
2025-11-05 12:37:47,361 - DEBUG - ya.test - _save_outputs: Command (pid 2679761) msgrcv: 0
2025-11-05 12:37:47,361 - DEBUG - ya.test - _save_outputs: Command (pid 2679761) msgsnd: 0
2025-11-05 12:37:47,362 - DEBUG - ya.test - _save_outputs: Command (pid 2679761) nivcsw: 37
2025-11-05 12:37:47,362 - DEBUG - ya.test - _save_outputs: Command (pid 2679761) nsignals: 0
2025-11-05 12:37:47,363 - DEBUG - ya.test - _save_outputs: Command (pid 2679761) nswap: 0
2025-11-05 12:37:47,363 - DEBUG - ya.test - _save_outputs: Command (pid 2679761) nvcsw: 15
2025-11-05 12:37:47,363 - DEBUG - ya.test - _save_outputs: Command (pid 2679761) oublock: 8
2025-11-05 12:37:47,364 - DEBUG - ya.test - _save_outputs: Command (pid 2679761) stime: 0.214444
2025-11-05 12:37:47,364 - DEBUG - ya.test - _save_outputs: Command (pid 2679761) utime: 0.5343089999999999
2025-11-05 12:37:47,365 - DEBUG - ya.test - _save_outputs: Command (pid 2679761) wtime: 0.803
2025-11-05 12:37:47,365 - DEBUG - ya.test - _save_outputs: Command (pid 2679761) output:
Git info:
    Commit: bb8d7ee9685d84658f39bc9c7238597c599c6433
    Branch: 
    Author: Pisarenko Grigoriy <grigoriypisar@ydb.tech>
    Summary: Merge c59276c0e0e506b21793b800196e5a8048164207 into f38187482f0084fe7bc5ab264dbd7817a983fef9

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-anwhr6cmha
    Host information: 
        Linux ghrun-anwhr6cmha 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/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -fsanitize=address -Daddress_sanitizer_enabled -fno-omit-frame-pointer -fsanitize-blacklist=/home/runner/actions_runner/_work/ydb/ydb/build/sanitize-blacklist.txt -fno-sanitize-link-runtime -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-11-05 12:37:47,365 - DEBUG - ya.test - _save_outputs: Command (pid 2679761) errors:

2025-11-05 12:37:47,366 - INFO - __tests__.base - _setup_ydb: Git info:
    Commit: bb8d7ee9685d84658f39bc9c7238597c599c6433
    Branch: 
    Author: Pisarenko Grigoriy <grigoriypisar@ydb.tech>
    Summary: Merge c59276c0e0e506b21793b800196e5a8048164207 into f38187482f0084fe7bc5ab264dbd7817a983fef9

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-anwhr6cmha
    Host information: 
        Linux ghrun-anwhr6cmha 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/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -fsanitize=address -Daddress_sanitizer_enabled -fno-omit-frame-pointer -fsanitize-blacklist=/home/runner/actions_runner/_work/ydb/ydb/build/sanitize-blacklist.txt -fno-sanitize-link-runtime -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-11-05 12:37:47,505 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/c688/002800/ydb/apps/ydbd/ydbd
2025-11-05 12:37:47,507 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/13670
2025-11-05 12:37:47,509 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/c688/002800/r3tmp/kikimr_cluster_nxxu_rd0
2025-11-05 12:37:47,558 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/c688/002800/ydb/apps/ydbd/ydbd
2025-11-05 12:37:47,559 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/24933
2025-11-05 12:37:47,560 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/61069
2025-11-05 12:37:47,560 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/3542
2025-11-05 12:37:47,561 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/13467
2025-11-05 12:37:47,562 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/c688/002800/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/kikimr_configs"
2025-11-05 12:37:47,563 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/c688/002800/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/c688/002800/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/node_1/logfile_vzc9jitp.log --grpc-port=24933 --mon-port=61069 --ic-port=13670
2025-11-05 12:37:47,563 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:24933/1, disk_size 68719476736
2025-11-05 12:37:47,564 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/c688/002800/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/kikimr_configs"
2025-11-05 12:37:47,564 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/c688/002800/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/c688/002800/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/node_1/logfile_vzc9jitp.log --grpc-port=24933 --mon-port=61069 --ic-port=13670
2025-11-05 12:37:47,566 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/c688/002800/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/c688/002800/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/c688/002800/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/node_1/logfile_vzc9jitp.log', '--grpc-port=24933', '--mon-port=61069', '--ic-port=13670')' in '/home/runner/.ya/build/build_root/c688/002800/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk9/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_compression-COMPRESSION.=.zstd/cluster/node_1' (no wait)
2025-11-05 12:37:47,569 - DEBUG - ya.test - execute: Command pid: 2680026
2025-11-05 12:37:47,570 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:24933/1
2025-11-05 12:37:47,572 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-05 12:37:47,573 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-05 12:37:47,573 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/c688/002800/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-05 12:37:47,575 - DEBUG - ya.test - execute: Command pid: 2680033
2025-11-05 12:37:48,346 - DEBUG - ya.test - _save_outputs: Command (pid 2680033) rc: 0
2025-11-05 12:37:48,347 - DEBUG - ya.test - _save_outputs: Command (pid 2680033) elapsed time (sec): 0.7699275016784668
2025-11-05 12:37:48,347 - DEBUG - ya.test - _save_outputs: Command (pid 2680033) idrss: 0
2025-11-05 12:37:48,347 - DEBUG - ya.test - _save_outputs: Command (pid 2680033) inblock: 0
2025-11-05 12:37:48,348 - DEBUG - ya.test - _save_outputs: Command (pid 2680033) isrss: 0
2025-11-05 12:37:48,348 - DEBUG - ya.test - _save_outputs: Command (pid 2680033) ixrss: 0
2025-11-05 12:37:48,348 - DEBUG - ya.test - _save_outputs: Command (pid 2680033) majflt: 0
2025-11-05 12:37:48,348 - DEBUG - ya.test - _save_outputs: Command (pid 2680033) maxrss: 496352
2025-11-05 12:37:48,349 - DEBUG - ya.test - _save_outputs: Command (pid 2680033) minflt: 45382
2025-11-05 12:37:48,349 - DEBUG - ya.test - _save_outputs: Command (pid 2680033) msgrcv: 0
2025-11-05 12:37:48,349 - DEBUG - ya.test - _save_outputs: Command (pid 2680033) msgsnd: 0
2025-11-05 12:37:48,350 - DEBUG - ya.test - _save_outputs: Command (pid 2680033) nivcsw: 22
2025-11-05 12:37:48,350 - DEBUG - ya.test - _save_outputs: Command (pid 2680033) nsignals: 0
2025-11-05 12:37:48,350 - DEBUG - ya.test - _save_outputs: Command (pid 2680033) nswap: 0
2025-11-05 12:37:48,351 - DEBUG - ya.test - _save_outputs: Command (pid 2680033) nvcsw: 14
2025-11-05 12:37:48,351 - DEBUG - ya.test - _save_outputs: Command (pid 2680033) oublock: 8
2025-11-05 12:37:48,351 - DEBUG - ya.test - _save_outputs: Command (pid 2680033) stime: 0.19719799999999998
2025-11-05 12:37:48,352 - DEBUG - ya.test - _save_outputs: Command (pid 2680033) utime: 0.526234
2025-11-05 12:37:48,352 - DEBUG - ya.test - _save_outputs: Command (pid 2680033) wtime: 0.772
2025-11-05 12:37:48,352 - DEBUG - ya.test - _save_outputs: Command (pid 2680033) output:
Git info:
    Commit: bb8d7ee9685d84658f39bc9c7238597c599c6433
    Branch: 
    Author: Pisarenko Grigoriy <grigoriypisar@ydb.tech>
    Summary: Merge c59276c0e0e506b21793b800196e5a8048164207 into f38187482f0084fe7bc5ab264dbd7817a983fef9

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-anwhr6cmha
    Host information: 
        Linux ghrun-anwhr6cmha 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/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -fsanitize=address -Daddress_sanitizer_enabled -fno-omit-frame-pointer -fsanitize-blacklist=/home/runner/actions_runner/_work/ydb/ydb/build/sanitize-blacklist.txt -fno-sanitize-link-runtime -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-11-05 12:37:48,353 - DEBUG - ya.test - _save_outputs: Command (pid 2680033) errors:

2025-11-05 12:37:48,353 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: bb8d7ee9685d84658f39bc9c7238597c599c6433
    Branch: 
    Author: Pisarenko Grigoriy <grigoriypisar@ydb.tech>
    Summary: Merge c59276c0e0e506b21793b800196e5a8048164207 into f38187482f0084fe7bc5ab264dbd7817a983fef9
2025-11-05 12:37:50,980 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/c688/002800/ydb/apps/ydbd/ydbd
2025-11-05 12:37:50,981 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/c688/002800/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:24933', '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: 13670\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-05 12:37:50,982 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-05 12:37:50,983 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-05 12:37:50,984 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/c688/002800/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:24933', '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: 13670\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-05 12:37:50,988 - DEBUG - ya.test - execute: Command pid: 2680733
2025-11-05 12:37:51,854 - DEBUG - ya.test - _save_outputs: Command (pid 2680733) rc: 0
2025-11-05 12:37:51,855 - DEBUG - ya.test - _save_outputs: Command (pid 2680733) elapsed time (sec): 0.8645133972167969
2025-11-05 12:37:51,855 - DEBUG - ya.test - _save_outputs: Command (pid 2680733) idrss: 0
2025-11-05 12:37:51,855 - DEBUG - ya.test - _save_outputs: Command (pid 2680733) inblock: 0
2025-11-05 12:37:51,856 - DEBUG - ya.test - _save_outputs: Command (pid 2680733) isrss: 0
2025-11-05 12:37:51,856 - DEBUG - ya.test - _save_outputs: Command (pid 2680733) ixrss: 0
2025-11-05 12:37:51,856 - DEBUG - ya.test - _save_outputs: Command (pid 2680733) majflt: 0
2025-11-05 12:37:51,856 - DEBUG - ya.test - _save_outputs: Command (pid 2680733) maxrss: 574944
2025-11-05 12:37:51,857 - DEBUG - ya.test - _save_outputs: Command (pid 2680733) minflt: 51701
2025-11-05 12:37:51,857 - DEBUG - ya.test - _save_outputs: Command (pid 2680733) msgrcv: 0
2025-11-05 12:37:51,857 - DEBUG - ya.test - _save_outputs: Command (pid 2680733) msgsnd: 0
2025-11-05 12:37:51,858 - DEBUG - ya.test - _save_outputs: Command (pid 2680733) nivcsw: 42
2025-11-05 12:37:51,858 - DEBUG - ya.test - _save_outputs: Command (pid 2680733) nsignals: 0
2025-11-05 12:37:51,859 - DEBUG - ya.test - _save_outputs: Command (pid 2680733) nswap: 0
2025-11-05 12:37:51,859 - DEBUG - ya.test - _save_outputs: Command (pid 2680733) nvcsw: 583
2025-11-05 12:37:51,859 - DEBUG - ya.test - _save_outputs: Command (pid 2680733) oublock: 8
2025-11-05 12:37:51,860 - DEBUG - ya.test - _save_outputs: Command (pid 2680733) stime: 0.25262999999999997
2025-11-05 12:37:51,860 - DEBUG - ya.test - _save_outputs: Command (pid 2680733) utime: 0.5424559999999999
2025-11-05 12:37:51,860 - DEBUG - ya.test - _save_outputs: Command (pid 2680733) wtime: 0.87
2025-11-05 12:37:51,861 - DEBUG - ya.test - _save_outputs: Command (pid 2680733) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-05 12:37:51,861 - DEBUG - ya.test - _save_outputs: Command (pid 2680733) errors:

2025-11-05 12:37:51,863 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/c688/002800/ydb/apps/ydbd/ydbd
2025-11-05 12:37:51,863 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/c688/002800/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:24933', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']
2025-11-05 12:37:51,865 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-05 12:37:51,866 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-05 12:37:51,866 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/c688/002800/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:24933', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-05 12:37:51,879 - DEBUG - ya.test - execute: Command pid: 2680937
2025-11-05 12:37:52,731 - DEBUG - ya.test - _save_outputs: Command (pid 2680937) rc: 0
2025-11-05 12:37:52,731 - DEBUG - ya.test - _save_outputs: Command (pid 2680937) elapsed time (sec): 0.851006031036377
2025-11-05 12:37:52,732 - DEBUG - ya.test - _save_outputs: Command (pid 2680937) idrss: 0
2025-11-05 12:37:52,732 - DEBUG - ya.test - _save_outputs: Command (pid 2680937) inblock: 0
2025-11-05 12:37:52,732 - DEBUG - ya.test - _save_outputs: Command (pid 2680937) isrss: 0
2025-11-05 12:37:52,733 - DEBUG - ya.test - _save_outputs: Command (pid 2680937) ixrss: 0
2025-11-05 12:37:52,733 - DEBUG - ya.test - _save_outputs: Command (pid 2680937) majflt: 0
2025-11-05 12:37:52,733 - DEBUG - ya.test - _save_outputs: Command (pid 2680937) maxrss: 575944
2025-11-05 12:37:52,733 - DEBUG - ya.test - _save_outputs: Command (pid 2680937) minflt: 51637
2025-11-05 12:37:52,734 - DEBUG - ya.test - _save_outputs: Command (pid 2680937) msgrcv: 0
2025-11-05 12:37:52,734 - DEBUG - ya.test - _save_outputs: Command (pid 2680937) msgsnd: 0
2025-11-05 12:37:52,734 - DEBUG - ya.test - _save_outputs: Command (pid 2680937) nivcsw: 27
2025-11-05 12:37:52,734 - DEBUG - ya.test - _save_outputs: Command (pid 2680937) nsignals: 0
2025-11-05 12:37:52,735 - DEBUG - ya.test - _save_outputs: Command (pid 2680937) nswap: 0
2025-11-05 12:37:52,735 - DEBUG - ya.test - _save_outputs: Command (pid 2680937) nvcsw: 766
2025-11-05 12:37:52,735 - DEBUG - ya.test - _save_outputs: Command (pid 2680937) oublock: 8
2025-11-05 12:37:52,735 - DEBUG - ya.test - _save_outputs: Command (pid 2680937) stime: 0.251723
2025-11-05 12:37:52,736 - DEBUG - ya.test - _save_outputs: Command (pid 2680937) utime: 0.573525
2025-11-05 12:37:52,736 - DEBUG - ya.test - _save_outputs: Command (pid 2680937) wtime: 0.859
2025-11-05 12:37:52,736 - DEBUG - ya.test - _save_outputs: Command (pid 2680937) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-11-05 12:37:52,736 - DEBUG - ya.test - _save_outputs: Command (pid 2680937) errors:

2025-11-05 12:37:52,737 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-05 12:37:52,779 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-05 12:37:52,835 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-05 12:37:52,838 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-05 12:37:52,841 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-05 12:37:52,855 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-05 12:37:52,856 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, ac74ebad-3a1e-479a-b7c3-8fad7da6a362, localhost:24933): creating call state
2025-11-05 12:37:52,856 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, ac74ebad-3a1e-479a-b7c3-8fad7da6a362, localhost:24933): request = { database: "/Root" }
2025-11-05 12:37:52,864 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, ac74ebad-3a1e-479a-b7c3-8fad7da6a362, localhost:24933): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-anwhr6cmha.auto.internal" port: 24933 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-11-05 12:37:52,865 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-anwhr6cmha.auto.internal:24933, location 1, ssl: False>]>
2025-11-05 12:37:52,865 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-05 12:37:52,877 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:24933
2025-11-05 12:37:52,878 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-05 12:37:52,880 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 7af20791-9c09-4717-9e4e-3856b3fb1fd7, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:37:52,880 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 7af20791-9c09-4717-9e4e-3856b3fb1fd7, ghrun-anwhr6cmha.auto.internal:24933): request = {  }
2025-11-05 12:37:52,887 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 7af20791-9c09-4717-9e4e-3856b3fb1fd7, ghrun-anwhr6cmha.auto.internal:24933): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" node_id: 1 }
2025-11-05 12:37:52,888 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, c71e41a1-90c1-4af2-9a44-ca5ed347c5b3, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:37:52,888 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, c71e41a1-90c1-4af2-9a44-ca5ed347c5b3, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" }
2025-11-05 12:37:52,890 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, c71e41a1-90c1-4af2-9a44-ca5ed347c5b3, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:37:52,893 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:37:52,894 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1de359df-5cc9-4f15-8fbc-dbcbefc79311, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:37:52,894 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1de359df-5cc9-4f15-8fbc-dbcbefc79311, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/off_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"off\")\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:37:52,895 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1de359df-5cc9-4f15-8fbc-dbcbefc79311, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:37:54,911 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:37:54,912 - INFO - __tests__.alter_compression - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-11-05 12:37:54,912 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:37:54,913 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 00bb477a-3238-40ff-be3b-0f4e02ad4b14, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:37:54,914 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 00bb477a-3238-40ff-be3b-0f4e02ad4b14, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/off_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:37:54,919 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 00bb477a-3238-40ff-be3b-0f4e02ad4b14, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:37:55,666 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:37:55,667 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:37:55,667 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4a9bc25a-1107-46d6-8224-6a7a5192047f, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:37:55,668 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4a9bc25a-1107-46d6-8224-6a7a5192047f, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 0;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:37:55,670 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4a9bc25a-1107-46d6-8224-6a7a5192047f, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:37:56,601 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:37:56,601 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:37:56,602 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, effa7eab-997c-48d3-8834-3e588c3b752d, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:37:56,603 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, effa7eab-997c-48d3-8834-3e588c3b752d, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:37:56,604 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, effa7eab-997c-48d3-8834-3e588c3b752d, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:37:57,276 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:37:57,277 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:37:57,278 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1550b68e-aa88-4cf4-a10a-25511774dee7, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:37:57,278 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1550b68e-aa88-4cf4-a10a-25511774dee7, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:37:57,283 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1550b68e-aa88-4cf4-a10a-25511774dee7, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:37:58,495 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:37:58,496 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 1618432, 'BlobCount': 128}}
2025-11-05 12:37:58,496 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:37:58,497 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 89ac34da-4c9c-415d-8e90-981763667455, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:37:58,498 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 89ac34da-4c9c-415d-8e90-981763667455, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 100000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:37:58,499 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 89ac34da-4c9c-415d-8e90-981763667455, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:37:59,295 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:37:59,296 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:37:59,297 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f2ac3ace-df70-4d9b-95f5-a38bba8a2729, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:37:59,297 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f2ac3ace-df70-4d9b-95f5-a38bba8a2729, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:37:59,299 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f2ac3ace-df70-4d9b-95f5-a38bba8a2729, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:37:59,466 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:37:59,467 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:37:59,468 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b5634433-e69a-4b89-b65b-4b7c02743d4e, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:37:59,468 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b5634433-e69a-4b89-b65b-4b7c02743d4e, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:37:59,470 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b5634433-e69a-4b89-b65b-4b7c02743d4e, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:37:59,693 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:37:59,693 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 3236864, 'BlobCount': 256}}
2025-11-05 12:37:59,694 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:37:59,695 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 12a59f28-12af-48cb-823f-7d7d9865c6e3, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:37:59,696 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 12a59f28-12af-48cb-823f-7d7d9865c6e3, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 200000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:37:59,697 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 12a59f28-12af-48cb-823f-7d7d9865c6e3, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:00,512 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:00,512 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:00,513 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, bf3cc21b-92a4-4cb8-b83d-237dd7318dd1, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:00,514 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, bf3cc21b-92a4-4cb8-b83d-237dd7318dd1, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:00,515 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, bf3cc21b-92a4-4cb8-b83d-237dd7318dd1, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:00,735 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:00,736 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:00,737 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6515142f-e072-4a3c-80d3-22dda7822d02, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:00,738 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6515142f-e072-4a3c-80d3-22dda7822d02, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:00,739 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6515142f-e072-4a3c-80d3-22dda7822d02, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:01,047 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:01,048 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 4855296, 'BlobCount': 384}}
2025-11-05 12:38:01,049 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:01,049 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 52cfe927-66d6-4bd4-97ec-dce62ba4d767, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:01,051 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 52cfe927-66d6-4bd4-97ec-dce62ba4d767, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 300000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:01,053 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 52cfe927-66d6-4bd4-97ec-dce62ba4d767, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:01,930 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:01,931 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:01,931 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 403ae58e-1dd4-4292-a895-1ae023ba6d2c, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:01,932 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 403ae58e-1dd4-4292-a895-1ae023ba6d2c, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:01,934 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 403ae58e-1dd4-4292-a895-1ae023ba6d2c, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:02,144 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:02,145 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:02,170 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6024721a-d44a-4135-9bdf-79e74ba81f0e, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:02,171 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6024721a-d44a-4135-9bdf-79e74ba81f0e, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:02,172 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6024721a-d44a-4135-9bdf-79e74ba81f0e, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:02,515 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:02,516 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 6473728, 'BlobCount': 512}}
2025-11-05 12:38:02,516 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:02,517 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 61e5d80e-ce91-4690-87e5-2c6e9fdd4d2e, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:02,518 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 61e5d80e-ce91-4690-87e5-2c6e9fdd4d2e, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 400000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:02,519 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 61e5d80e-ce91-4690-87e5-2c6e9fdd4d2e, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:03,460 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:03,461 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:03,461 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 37cd8cd8-56e2-42d0-baa1-b7bba61ff2c9, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:03,462 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 37cd8cd8-56e2-42d0-baa1-b7bba61ff2c9, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:03,463 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 37cd8cd8-56e2-42d0-baa1-b7bba61ff2c9, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:03,663 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:03,664 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:03,665 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 49feb113-66ee-4402-ae72-aa8dee1086e5, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:03,666 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 49feb113-66ee-4402-ae72-aa8dee1086e5, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:03,667 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 49feb113-66ee-4402-ae72-aa8dee1086e5, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:04,070 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:04,071 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 8092160, 'BlobCount': 640}}
2025-11-05 12:38:04,071 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:04,072 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b9277f73-570e-4b7f-ada3-4381f9dd4a5f, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:04,073 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b9277f73-570e-4b7f-ada3-4381f9dd4a5f, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 500000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:04,076 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b9277f73-570e-4b7f-ada3-4381f9dd4a5f, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:05,014 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:05,014 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:05,015 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6748ee9f-954f-4dd0-95db-1bb292a22d35, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:05,016 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6748ee9f-954f-4dd0-95db-1bb292a22d35, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:05,018 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6748ee9f-954f-4dd0-95db-1bb292a22d35, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:05,276 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:05,277 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:05,277 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9fcfe871-62f5-4755-a495-c48f5cf5a8e2, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:05,278 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9fcfe871-62f5-4755-a495-c48f5cf5a8e2, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:05,280 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9fcfe871-62f5-4755-a495-c48f5cf5a8e2, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:05,712 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:05,713 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 9710592, 'BlobCount': 768}}
2025-11-05 12:38:05,713 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:05,714 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c6767cde-ae7c-4303-a23e-1e991cd39184, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:05,715 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c6767cde-ae7c-4303-a23e-1e991cd39184, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 600000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:05,719 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c6767cde-ae7c-4303-a23e-1e991cd39184, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:06,653 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:06,654 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:06,654 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9f56b37c-b90f-4303-a528-715f7cdd228c, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:06,655 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9f56b37c-b90f-4303-a528-715f7cdd228c, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:06,657 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9f56b37c-b90f-4303-a528-715f7cdd228c, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:06,834 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:06,835 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:06,836 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7e7bd6f0-de88-4b7a-88eb-9d0204485a5f, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:06,837 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7e7bd6f0-de88-4b7a-88eb-9d0204485a5f, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:06,840 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7e7bd6f0-de88-4b7a-88eb-9d0204485a5f, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:07,278 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:07,279 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 11329024, 'BlobCount': 896}}
2025-11-05 12:38:07,279 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:07,280 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 79a8d5e8-2677-4ea0-b70b-3c91523ad36d, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:07,281 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 79a8d5e8-2677-4ea0-b70b-3c91523ad36d, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 700000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:07,283 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 79a8d5e8-2677-4ea0-b70b-3c91523ad36d, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:08,161 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:08,162 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:08,162 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c14f7dcb-1eff-4969-9446-1d139aa705b9, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:08,163 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c14f7dcb-1eff-4969-9446-1d139aa705b9, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:08,164 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c14f7dcb-1eff-4969-9446-1d139aa705b9, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:08,392 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:08,393 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:08,394 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6d157284-6f68-47a0-8fe7-dde4932de558, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:08,395 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6d157284-6f68-47a0-8fe7-dde4932de558, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:08,396 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6d157284-6f68-47a0-8fe7-dde4932de558, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:08,928 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:08,928 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 12947456, 'BlobCount': 1024}}
2025-11-05 12:38:08,929 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:08,929 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6c1fea01-331a-46c1-a96b-d7541582d096, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:08,930 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6c1fea01-331a-46c1-a96b-d7541582d096, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 800000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:08,932 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6c1fea01-331a-46c1-a96b-d7541582d096, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:09,784 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:09,785 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:09,786 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0b1b55ba-a200-440c-bfa0-d28b049633f5, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:09,786 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0b1b55ba-a200-440c-bfa0-d28b049633f5, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:09,788 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0b1b55ba-a200-440c-bfa0-d28b049633f5, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:10,032 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:10,032 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:10,033 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 364d50ac-24c5-4a6c-a2df-c381a52096be, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:10,034 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 364d50ac-24c5-4a6c-a2df-c381a52096be, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:10,036 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 364d50ac-24c5-4a6c-a2df-c381a52096be, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:10,624 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:10,625 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 14565888, 'BlobCount': 1152}}
2025-11-05 12:38:10,625 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:10,626 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 943fd465-be5e-4c13-bfd7-5a3c8c4b98bf, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:10,628 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 943fd465-be5e-4c13-bfd7-5a3c8c4b98bf, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                $row_count = 100000;\n                $prev_count = 900000;\n                $rows= ListMap(ListFromRange(0, $row_count), ($i) -> {\n                    return <|\n                        value: $i + $prev_count,\n                        value1: $i + $prev_count,\n                    |>;\n                });\n                UPSERT INTO `/Root/all_compression/all_supported_compression/off_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:10,629 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 943fd465-be5e-4c13-bfd7-5a3c8c4b98bf, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:11,567 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:11,567 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:11,568 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 31abd0a2-77e4-422d-9aa6-c2decdb5c654, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:11,569 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 31abd0a2-77e4-422d-9aa6-c2decdb5c654, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:11,575 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 31abd0a2-77e4-422d-9aa6-c2decdb5c654, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:11,808 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:11,808 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:11,809 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 439e6037-273f-4079-9cc2-db0dded8761a, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:11,809 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 439e6037-273f-4079-9cc2-db0dded8761a, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n            select TierName, count(*) as Portions, sum(BlobSize) as BlobSize, sum(BlobCount) as BlobCount from (\n                select TabletId, PortionId, TierName, sum(BlobRangeSize) as BlobSize, count(*) as BlobCount from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:11,811 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 439e6037-273f-4079-9cc2-db0dded8761a, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:12,431 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:12,432 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/off_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 16184320, 'BlobCount': 1280}}
2025-11-05 12:38:12,432 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:12,433 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e7081509-134d-41cc-8b2f-f21fab2e415d, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:12,433 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e7081509-134d-41cc-8b2f-f21fab2e415d, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/off_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:12,435 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e7081509-134d-41cc-8b2f-f21fab2e415d, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:13,407 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:13,407 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:13,408 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8517e436-3cd0-4c13-ac1f-2efe3265f39e, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:13,408 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8517e436-3cd0-4c13-ac1f-2efe3265f39e, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:13,410 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8517e436-3cd0-4c13-ac1f-2efe3265f39e, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:13,716 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:13,716 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:13,717 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6a10e18d-461f-4550-aaeb-4a7a23ec4bda, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:13,718 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6a10e18d-461f-4550-aaeb-4a7a23ec4bda, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:13,720 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6a10e18d-461f-4550-aaeb-4a7a23ec4bda, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:13,970 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:13,971 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:13,971 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3f905358-93dd-4419-8998-6a3df05ddad8, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:13,972 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3f905358-93dd-4419-8998-6a3df05ddad8, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:13,973 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3f905358-93dd-4419-8998-6a3df05ddad8, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:17,711 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:27,776 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:27,777 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 99c0d52c-aa33-4516-a781-d76a1dd210d9, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:27,778 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 99c0d52c-aa33-4516-a781-d76a1dd210d9, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:27,780 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 99c0d52c-aa33-4516-a781-d76a1dd210d9, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:30,309 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:30,355 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-05 12:38:30,356 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:30,356 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 65eb84fb-882a-49bf-91b7-696ae5cd86d6, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:30,357 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 65eb84fb-882a-49bf-91b7-696ae5cd86d6, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:30,359 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 65eb84fb-882a-49bf-91b7-696ae5cd86d6, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:33,160 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:43,198 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:43,199 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b3c77386-55a0-4cf0-a175-bfd0c7664664, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:43,200 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b3c77386-55a0-4cf0-a175-bfd0c7664664, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:43,201 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b3c77386-55a0-4cf0-a175-bfd0c7664664, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:45,855 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:45,915 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-05 12:38:45,916 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:45,917 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e103fe6b-1147-48f6-9e0f-da8f7b2fe7b6, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:45,918 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e103fe6b-1147-48f6-9e0f-da8f7b2fe7b6, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "select TierName, sum(Rows) as Rows, count(*) as Portions from `/Root/all_compression/all_supported_compression/off_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:45,919 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e103fe6b-1147-48f6-9e0f-da8f7b2fe7b6, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:46,176 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:46,180 - INFO - ya.test - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_compression-COMPRESSION = "zstd"])
2025-11-05 12:38:46,181 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:46,182 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b81f9b42-4187-45dd-b831-aebb37936685, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:46,183 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b81f9b42-4187-45dd-b831-aebb37936685, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\")\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:46,184 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b81f9b42-4187-45dd-b831-aebb37936685, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:49,139 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:49,140 - INFO - __tests__.alter_compression - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_compression created
2025-11-05 12:38:49,141 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:49,141 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3b772f58-01fb-4a26-873b-a085bd030120, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:49,142 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3b772f58-01fb-4a26-873b-a085bd030120, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:49,144 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3b772f58-01fb-4a26-873b-a085bd030120, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:49,880 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:49,880 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:49,881 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, fa4aeecc-ee95-4d90-a53b-6b9713649900, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:49,882 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, fa4aeecc-ee95-4d90-a53b-6b9713649900, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:49,884 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, fa4aeecc-ee95-4d90-a53b-6b9713649900, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:51,055 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:51,056 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:51,056 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, af0afc4f-0f68-4a83-b574-ca5e82055470, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:51,057 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, af0afc4f-0f68-4a83-b574-ca5e82055470, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:51,059 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, af0afc4f-0f68-4a83-b574-ca5e82055470, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:51,917 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:51,918 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:51,919 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b4ab9637-3c91-4939-a385-7ea34cb8cb76, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:51,920 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b4ab9637-3c91-4939-a385-7ea34cb8cb76, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:51,927 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b4ab9637-3c91-4939-a385-7ea34cb8cb76, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:53,598 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:53,599 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318880, 'BlobCount': 128}}
2025-11-05 12:38:53,599 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:53,600 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0ea3cbe6-fe2c-4a09-a457-0f73bcb3ac91, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:53,601 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0ea3cbe6-fe2c-4a09-a457-0f73bcb3ac91, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:53,602 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0ea3cbe6-fe2c-4a09-a457-0f73bcb3ac91, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:55,419 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:55,419 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:55,420 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 63c42984-81d0-46b3-992a-4eb6c0c2a625, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:55,421 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 63c42984-81d0-46b3-992a-4eb6c0c2a625, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:55,423 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 63c42984-81d0-46b3-992a-4eb6c0c2a625, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:55,776 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:55,777 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:55,778 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 40e3642e-8f1f-46a0-96e2-d3e29acc73d8, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:55,778 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 40e3642e-8f1f-46a0-96e2-d3e29acc73d8, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:55,780 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 40e3642e-8f1f-46a0-96e2-d3e29acc73d8, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:56,331 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:56,332 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 638384, 'BlobCount': 256}}
2025-11-05 12:38:56,332 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:56,333 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 07df2bc8-f32b-4045-bb48-dd62f0371027, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:56,334 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 07df2bc8-f32b-4045-bb48-dd62f0371027, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:56,335 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 07df2bc8-f32b-4045-bb48-dd62f0371027, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:57,402 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:57,403 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:57,404 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 066548c3-27ff-42ab-8482-9a42dee7cd89, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:57,405 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 066548c3-27ff-42ab-8482-9a42dee7cd89, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:57,406 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 066548c3-27ff-42ab-8482-9a42dee7cd89, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:57,683 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:57,684 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:57,684 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, df25fd1d-b7d5-4487-b758-24728b8ca1f8, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:57,685 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, df25fd1d-b7d5-4487-b758-24728b8ca1f8, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:57,687 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, df25fd1d-b7d5-4487-b758-24728b8ca1f8, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:58,130 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:58,131 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 957552, 'BlobCount': 384}}
2025-11-05 12:38:58,131 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:58,132 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, a5555504-dbf7-4624-a804-6d1c6aa94e5f, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:58,133 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, a5555504-dbf7-4624-a804-6d1c6aa94e5f, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:58,135 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, a5555504-dbf7-4624-a804-6d1c6aa94e5f, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:59,322 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:59,322 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:59,323 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b6deed93-f653-4d77-8e4b-8e3444956cf2, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:59,324 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b6deed93-f653-4d77-8e4b-8e3444956cf2, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:59,325 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b6deed93-f653-4d77-8e4b-8e3444956cf2, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:38:59,755 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:59,756 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:38:59,757 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, be2e645d-ba1b-44ca-ae64-1ea2cbc623bf, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:38:59,757 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, be2e645d-ba1b-44ca-ae64-1ea2cbc623bf, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:38:59,759 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, be2e645d-ba1b-44ca-ae64-1ea2cbc623bf, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:39:00,386 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:00,387 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1277056, 'BlobCount': 512}}
2025-11-05 12:39:00,387 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:00,388 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 39c78fdd-9979-4a94-96c9-0aa4aeaefb39, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:39:00,389 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 39c78fdd-9979-4a94-96c9-0aa4aeaefb39, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:39:00,391 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 39c78fdd-9979-4a94-96c9-0aa4aeaefb39, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:39:01,852 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:01,853 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:01,854 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 459b1dd5-7adb-4ec7-a45d-8ad9e56b5403, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:39:01,855 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 459b1dd5-7adb-4ec7-a45d-8ad9e56b5403, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:39:01,856 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 459b1dd5-7adb-4ec7-a45d-8ad9e56b5403, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:39:02,196 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:02,197 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:02,197 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5509e1f1-3d9f-4cb6-bc79-0202f3e67fc0, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:39:02,198 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5509e1f1-3d9f-4cb6-bc79-0202f3e67fc0, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:39:02,199 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5509e1f1-3d9f-4cb6-bc79-0202f3e67fc0, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:39:02,679 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:02,680 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1596256, 'BlobCount': 640}}
2025-11-05 12:39:02,681 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:02,682 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b38a2662-d3f2-4a67-92d2-0cad3384b268, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:39:02,683 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b38a2662-d3f2-4a67-92d2-0cad3384b268, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:39:02,684 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b38a2662-d3f2-4a67-92d2-0cad3384b268, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:39:03,647 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:03,648 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:03,648 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 84203bfd-6aa8-44fe-9b6f-66b2d8b12c2c, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:39:03,649 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 84203bfd-6aa8-44fe-9b6f-66b2d8b12c2c, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:39:03,651 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 84203bfd-6aa8-44fe-9b6f-66b2d8b12c2c, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:39:03,871 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:03,872 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:03,873 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 749af531-341d-4bee-b07d-c3c438e9b7f6, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:39:03,874 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 749af531-341d-4bee-b07d-c3c438e9b7f6, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:39:03,879 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 749af531-341d-4bee-b07d-c3c438e9b7f6, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:39:04,339 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:04,340 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1915600, 'BlobCount': 768}}
2025-11-05 12:39:04,340 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:04,341 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e39ccdd2-4593-4873-99da-84ace9fcaf97, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:39:04,342 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e39ccdd2-4593-4873-99da-84ace9fcaf97, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:39:04,343 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e39ccdd2-4593-4873-99da-84ace9fcaf97, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:39:05,511 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:05,511 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:05,512 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 772558bb-3268-4f47-a508-6237e473406a, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:39:05,514 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 772558bb-3268-4f47-a508-6237e473406a, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:39:05,516 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 772558bb-3268-4f47-a508-6237e473406a, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:39:05,755 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:05,756 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:05,757 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 607fa39d-ca1d-4cb0-92cd-6dc103a4d8fd, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:39:05,758 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 607fa39d-ca1d-4cb0-92cd-6dc103a4d8fd, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:39:05,760 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 607fa39d-ca1d-4cb0-92cd-6dc103a4d8fd, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:39:06,319 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:06,320 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2234896, 'BlobCount': 896}}
2025-11-05 12:39:06,321 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:06,321 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 035567cb-58b2-4694-8ee4-aea6acd456f6, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:39:06,322 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 035567cb-58b2-4694-8ee4-aea6acd456f6, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:39:06,324 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 035567cb-58b2-4694-8ee4-aea6acd456f6, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:39:07,403 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:07,404 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:07,404 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5d137149-ea18-4403-a6fc-b1bfa78e801c, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:39:07,405 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5d137149-ea18-4403-a6fc-b1bfa78e801c, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:39:07,407 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5d137149-ea18-4403-a6fc-b1bfa78e801c, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:39:07,711 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:07,711 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:07,712 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 891538a3-e27a-4836-ba28-381e4f5541fb, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:39:07,713 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 891538a3-e27a-4836-ba28-381e4f5541fb, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:39:07,714 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 891538a3-e27a-4836-ba28-381e4f5541fb, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:39:08,352 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:08,353 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2554464, 'BlobCount': 1024}}
2025-11-05 12:39:08,353 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:08,354 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 663039f0-7ea5-47e5-99e6-aca7f5b3f3c9, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:39:08,355 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 663039f0-7ea5-47e5-99e6-aca7f5b3f3c9, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:39:08,356 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 663039f0-7ea5-47e5-99e6-aca7f5b3f3c9, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:39:09,563 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:09,564 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:09,564 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 48cc6573-92cc-4dd8-b820-e88ef2a2f1c8, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:39:09,565 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 48cc6573-92cc-4dd8-b820-e88ef2a2f1c8, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:39:09,567 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 48cc6573-92cc-4dd8-b820-e88ef2a2f1c8, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:39:10,027 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:10,028 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:10,029 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b95abafe-6135-40d7-ba9d-fd6f07dcdac4, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:39:10,030 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b95abafe-6135-40d7-ba9d-fd6f07dcdac4, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:39:10,034 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b95abafe-6135-40d7-ba9d-fd6f07dcdac4, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:39:10,639 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:10,640 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2873568, 'BlobCount': 1152}}
2025-11-05 12:39:10,641 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:10,641 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 561a2dc5-70af-414e-bcbe-4da8b231671f, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:39:10,642 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 561a2dc5-70af-414e-bcbe-4da8b231671f, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:39:10,644 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 561a2dc5-70af-414e-bcbe-4da8b231671f, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:39:11,826 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:11,827 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:11,828 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 50c6fc95-2156-4bbc-a013-c07d48d8d174, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:39:11,829 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 50c6fc95-2156-4bbc-a013-c07d48d8d174, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:39:11,830 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 50c6fc95-2156-4bbc-a013-c07d48d8d174, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:39:12,179 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:12,179 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:12,180 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1130e85d-c838-4688-9564-5840e9a7865c, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:39:12,181 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1130e85d-c838-4688-9564-5840e9a7865c, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 12:39:12,183 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1130e85d-c838-4688-9564-5840e9a7865c, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:39:12,879 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:12,880 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3193216, 'BlobCount': 1280}}
2025-11-05 12:39:12,880 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:12,881 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, dd9a4299-4ddb-4435-9020-af52ff693283, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:39:12,882 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, dd9a4299-4ddb-4435-9020-af52ff693283, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:39:12,884 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, dd9a4299-4ddb-4435-9020-af52ff693283, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:39:13,959 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:13,960 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:13,960 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, dfe31996-02cd-4c81-b0ab-dc0d250d01e7, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:39:13,961 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, dfe31996-02cd-4c81-b0ab-dc0d250d01e7, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:39:13,963 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, dfe31996-02cd-4c81-b0ab-dc0d250d01e7, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:39:14,246 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:14,247 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:14,248 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 82368417-9bb1-4561-a959-99ee7117e9ae, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:39:14,249 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 82368417-9bb1-4561-a959-99ee7117e9ae, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:39:14,255 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 82368417-9bb1-4561-a959-99ee7117e9ae, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:39:14,589 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:14,590 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:14,591 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 558fd9c2-fb0d-4c5c-83ed-865e1e7580af, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:39:14,592 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 558fd9c2-fb0d-4c5c-83ed-865e1e7580af, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:39:14,599 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 558fd9c2-fb0d-4c5c-83ed-865e1e7580af, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:39:18,071 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:28,133 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:28,134 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 669fa413-4674-4f51-a46a-f87602c7bd0f, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:39:28,135 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 669fa413-4674-4f51-a46a-f87602c7bd0f, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:39:28,137 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 669fa413-4674-4f51-a46a-f87602c7bd0f, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:39:31,429 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:31,467 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_compression`, volumes `value` (8000000, 1596608)
2025-11-05 12:39:31,468 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:31,469 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 98d3ca54-e45a-4222-86ff-b76458baa636, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:39:31,470 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 98d3ca54-e45a-4222-86ff-b76458baa636, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" 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_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:39:31,471 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 98d3ca54-e45a-4222-86ff-b76458baa636, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:39:31,712 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:31,713 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:31,713 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0ee5a6fb-dc88-45ed-82ec-51358331c97b, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:39:31,714 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0ee5a6fb-dc88-45ed-82ec-51358331c97b, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:39:31,715 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0ee5a6fb-dc88-45ed-82ec-51358331c97b, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:39:35,041 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:44,278 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-05 12:39:44,279 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-05 12:39:44,294 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-05 12:39:44,295 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 4149af38-eaee-4673-bab5-dce756719a2d, localhost:24933): creating call state
2025-11-05 12:39:44,296 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 4149af38-eaee-4673-bab5-dce756719a2d, localhost:24933): request = { database: "/Root" }
2025-11-05 12:39:44,304 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 4149af38-eaee-4673-bab5-dce756719a2d, localhost:24933): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-anwhr6cmha.auto.internal" port: 24933 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-11-05 12:39:44,305 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-anwhr6cmha.auto.internal:24933, location 1, ssl: False>]>
2025-11-05 12:39:44,305 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:24933
2025-11-05 12:39:45,078 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:45,079 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 76574765-33fc-4e88-81d7-80fecdbbff7f, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:39:45,080 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 76574765-33fc-4e88-81d7-80fecdbbff7f, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-05 12:39:45,081 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 76574765-33fc-4e88-81d7-80fecdbbff7f, ghrun-anwhr6cmha.auto.internal:24933): response = { <_MultiThreadedRendezvous object> }
2025-11-05 12:39:48,326 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=
2025-11-05 12:39:48,367 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_compression`, volumes `value` (8000000, 1596608)
2025-11-05 12:39:48,368 - INFO - root - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_compression` 8092160 / 1596608: 5.0683448911692786
2025-11-05 12:39:48,370 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-11-05 12:39:48,371 - DEBUG - ydb.connection - _prepare_call: RpcState(DeleteSession, 50aa0ee3-0b6a-409a-a4b9-e73455361926, ghrun-anwhr6cmha.auto.internal:24933): creating call state
2025-11-05 12:39:48,372 - DEBUG - ydb.connection - _log_request: RpcState(DeleteSession, 50aa0ee3-0b6a-409a-a4b9-e73455361926, ghrun-anwhr6cmha.auto.internal:24933): request = { session_id: "ydb://session/3?node_id=1&id=ZWZhZWExZTYtMjY5YTEwZDYtMzJlNzNiZTUtYzZlMjgzMmY=" }
2025-11-05 12:39:48,375 - DEBUG - ydb.connection - _log_response: RpcState(DeleteSession, 50aa0ee3-0b6a-409a-a4b9-e73455361926, ghrun-anwhr6cmha.auto.internal:24933): response = { status: SUCCESS }
2025-11-05 12:39:48,377 - DEBUG - ydb.query.pool - stop: All session were deleted.
2025-11-05 12:39:48,377 - DEBUG - ydb.topic - close: Close topic client
2025-11-05 12:39:48,377 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-05 12:39:48,378 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:24933
2025-11-05 12:39:48,378 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-anwhr6cmha.auto.internal:24933
2025-11-05 12:39:48,384 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-11-05 12:39:48,403 - DEBUG - ydb.connection - _rpc_error_handler: RpcState(AttachSession, c71e41a1-90c1-4af2-9a44-ca5ed347c5b3, ghrun-anwhr6cmha.auto.internal:24933): received error, <_MultiThreadedRendezvous of RPC that terminated with:
	status = StatusCode.CANCELLED
	details = "Locally cancelled by application!"
	debug_error_string = "None"
>
2025-11-05 12:40:05,415 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:24933/1
2025-11-05 12:40:05,416 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/13467
2025-11-05 12:40:05,417 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/3542
2025-11-05 12:40:05,418 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/61069
2025-11-05 12:40:05,418 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/24933
2025-11-05 12:40:05,419 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/13670
