2025-11-05 11:50:49,359 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-05 11:50:49,360 - INFO - ya.test - pytest_runtest_setup: test_all_supported_compression[zstd_8_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 8]
2025-11-05 11:50:49,360 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-05 11:50:49,360 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-05 11:50:49,362 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-05 11:50:49,363 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-05 11:50:49,364 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/c688/0027b2/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-05 11:50:49,377 - DEBUG - ya.test - execute: Command pid: 1875067
2025-11-05 11:50:50,642 - DEBUG - ya.test - _save_outputs: Command (pid 1875067) rc: 0
2025-11-05 11:50:50,643 - DEBUG - ya.test - _save_outputs: Command (pid 1875067) elapsed time (sec): 1.2639002799987793
2025-11-05 11:50:50,643 - DEBUG - ya.test - _save_outputs: Command (pid 1875067) idrss: 0
2025-11-05 11:50:50,644 - DEBUG - ya.test - _save_outputs: Command (pid 1875067) inblock: 0
2025-11-05 11:50:50,644 - DEBUG - ya.test - _save_outputs: Command (pid 1875067) isrss: 0
2025-11-05 11:50:50,644 - DEBUG - ya.test - _save_outputs: Command (pid 1875067) ixrss: 0
2025-11-05 11:50:50,644 - DEBUG - ya.test - _save_outputs: Command (pid 1875067) majflt: 0
2025-11-05 11:50:50,645 - DEBUG - ya.test - _save_outputs: Command (pid 1875067) maxrss: 480592
2025-11-05 11:50:50,645 - DEBUG - ya.test - _save_outputs: Command (pid 1875067) minflt: 45399
2025-11-05 11:50:50,645 - DEBUG - ya.test - _save_outputs: Command (pid 1875067) msgrcv: 0
2025-11-05 11:50:50,645 - DEBUG - ya.test - _save_outputs: Command (pid 1875067) msgsnd: 0
2025-11-05 11:50:50,646 - DEBUG - ya.test - _save_outputs: Command (pid 1875067) nivcsw: 252
2025-11-05 11:50:50,646 - DEBUG - ya.test - _save_outputs: Command (pid 1875067) nsignals: 0
2025-11-05 11:50:50,646 - DEBUG - ya.test - _save_outputs: Command (pid 1875067) nswap: 0
2025-11-05 11:50:50,647 - DEBUG - ya.test - _save_outputs: Command (pid 1875067) nvcsw: 14
2025-11-05 11:50:50,647 - DEBUG - ya.test - _save_outputs: Command (pid 1875067) oublock: 8
2025-11-05 11:50:50,647 - DEBUG - ya.test - _save_outputs: Command (pid 1875067) stime: 0.212302
2025-11-05 11:50:50,648 - DEBUG - ya.test - _save_outputs: Command (pid 1875067) utime: 0.528095
2025-11-05 11:50:50,648 - DEBUG - ya.test - _save_outputs: Command (pid 1875067) wtime: 1.278
2025-11-05 11:50:50,648 - DEBUG - ya.test - _save_outputs: Command (pid 1875067) 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 11:50:50,649 - DEBUG - ya.test - _save_outputs: Command (pid 1875067) errors:

2025-11-05 11:50:50,649 - 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 11:50:50,933 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/c688/0027b2/ydb/apps/ydbd/ydbd
2025-11-05 11:50:50,935 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18144
2025-11-05 11:50:50,937 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/c688/0027b2/r3tmp/kikimr_cluster_d6sq4zzi
2025-11-05 11:50:51,006 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/c688/0027b2/ydb/apps/ydbd/ydbd
2025-11-05 11:50:51,015 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/16151
2025-11-05 11:50:51,016 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/29949
2025-11-05 11:50:51,016 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/2567
2025-11-05 11:50:51,017 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/9576
2025-11-05 11:50:51,018 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/c688/0027b2/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/kikimr_configs"
2025-11-05 11:50:51,018 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/c688/0027b2/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/0027b2/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/node_1/logfile_lggq9slk.log --grpc-port=16151 --mon-port=29949 --ic-port=18144
2025-11-05 11:50:51,019 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:16151/1, disk_size 68719476736
2025-11-05 11:50:51,019 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/c688/0027b2/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/kikimr_configs"
2025-11-05 11:50:51,020 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/c688/0027b2/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/0027b2/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/node_1/logfile_lggq9slk.log --grpc-port=16151 --mon-port=29949 --ic-port=18144
2025-11-05 11:50:51,021 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/c688/0027b2/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/c688/0027b2/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/c688/0027b2/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/node_1/logfile_lggq9slk.log', '--grpc-port=16151', '--mon-port=29949', '--ic-port=18144')' in '/home/runner/.ya/build/build_root/c688/0027b2/ydb/tests/olap/column_family/compression/test-results/py3test/testing_out_stuff/chunk8/testing_out_stuff/alter_compression.py.TestAllCompression.test_all_supported_compression.zstd_8_compression-COMPRESSION.=.zstd.,.COMPRESSION_LEVEL.=.8/cluster/node_1' (no wait)
2025-11-05 11:50:51,043 - DEBUG - ya.test - execute: Command pid: 1875941
2025-11-05 11:50:51,044 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:16151/1
2025-11-05 11:50:51,045 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-05 11:50:51,046 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-05 11:50:51,047 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/c688/0027b2/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-05 11:50:51,063 - DEBUG - ya.test - execute: Command pid: 1875942
2025-11-05 11:50:52,530 - DEBUG - ya.test - _save_outputs: Command (pid 1875942) rc: 0
2025-11-05 11:50:52,531 - DEBUG - ya.test - _save_outputs: Command (pid 1875942) elapsed time (sec): 1.4631054401397705
2025-11-05 11:50:52,531 - DEBUG - ya.test - _save_outputs: Command (pid 1875942) idrss: 0
2025-11-05 11:50:52,532 - DEBUG - ya.test - _save_outputs: Command (pid 1875942) inblock: 0
2025-11-05 11:50:52,532 - DEBUG - ya.test - _save_outputs: Command (pid 1875942) isrss: 0
2025-11-05 11:50:52,532 - DEBUG - ya.test - _save_outputs: Command (pid 1875942) ixrss: 0
2025-11-05 11:50:52,533 - DEBUG - ya.test - _save_outputs: Command (pid 1875942) majflt: 0
2025-11-05 11:50:52,533 - DEBUG - ya.test - _save_outputs: Command (pid 1875942) maxrss: 484444
2025-11-05 11:50:52,533 - DEBUG - ya.test - _save_outputs: Command (pid 1875942) minflt: 45320
2025-11-05 11:50:52,534 - DEBUG - ya.test - _save_outputs: Command (pid 1875942) msgrcv: 0
2025-11-05 11:50:52,534 - DEBUG - ya.test - _save_outputs: Command (pid 1875942) msgsnd: 0
2025-11-05 11:50:52,539 - DEBUG - ya.test - _save_outputs: Command (pid 1875942) nivcsw: 214
2025-11-05 11:50:52,539 - DEBUG - ya.test - _save_outputs: Command (pid 1875942) nsignals: 0
2025-11-05 11:50:52,540 - DEBUG - ya.test - _save_outputs: Command (pid 1875942) nswap: 0
2025-11-05 11:50:52,540 - DEBUG - ya.test - _save_outputs: Command (pid 1875942) nvcsw: 15
2025-11-05 11:50:52,540 - DEBUG - ya.test - _save_outputs: Command (pid 1875942) oublock: 8
2025-11-05 11:50:52,541 - DEBUG - ya.test - _save_outputs: Command (pid 1875942) stime: 0.228285
2025-11-05 11:50:52,541 - DEBUG - ya.test - _save_outputs: Command (pid 1875942) utime: 0.553183
2025-11-05 11:50:52,541 - DEBUG - ya.test - _save_outputs: Command (pid 1875942) wtime: 1.479
2025-11-05 11:50:52,542 - DEBUG - ya.test - _save_outputs: Command (pid 1875942) 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 11:50:52,542 - DEBUG - ya.test - _save_outputs: Command (pid 1875942) errors:

2025-11-05 11:50:52,546 - 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 11:50:59,348 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/c688/0027b2/ydb/apps/ydbd/ydbd
2025-11-05 11:50:59,348 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/c688/0027b2/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:16151', '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: 18144\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-05 11:50:59,349 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-05 11:50:59,350 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-05 11:50:59,351 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/c688/0027b2/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:16151', '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: 18144\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-05 11:50:59,367 - DEBUG - ya.test - execute: Command pid: 1877881
2025-11-05 11:51:00,826 - DEBUG - ya.test - _save_outputs: Command (pid 1877881) rc: 0
2025-11-05 11:51:00,826 - DEBUG - ya.test - _save_outputs: Command (pid 1877881) elapsed time (sec): 1.4542155265808105
2025-11-05 11:51:00,827 - DEBUG - ya.test - _save_outputs: Command (pid 1877881) idrss: 0
2025-11-05 11:51:00,827 - DEBUG - ya.test - _save_outputs: Command (pid 1877881) inblock: 0
2025-11-05 11:51:00,827 - DEBUG - ya.test - _save_outputs: Command (pid 1877881) isrss: 0
2025-11-05 11:51:00,827 - DEBUG - ya.test - _save_outputs: Command (pid 1877881) ixrss: 0
2025-11-05 11:51:00,828 - DEBUG - ya.test - _save_outputs: Command (pid 1877881) majflt: 0
2025-11-05 11:51:00,828 - DEBUG - ya.test - _save_outputs: Command (pid 1877881) maxrss: 600032
2025-11-05 11:51:00,828 - DEBUG - ya.test - _save_outputs: Command (pid 1877881) minflt: 51684
2025-11-05 11:51:00,828 - DEBUG - ya.test - _save_outputs: Command (pid 1877881) msgrcv: 0
2025-11-05 11:51:00,829 - DEBUG - ya.test - _save_outputs: Command (pid 1877881) msgsnd: 0
2025-11-05 11:51:00,829 - DEBUG - ya.test - _save_outputs: Command (pid 1877881) nivcsw: 248
2025-11-05 11:51:00,829 - DEBUG - ya.test - _save_outputs: Command (pid 1877881) nsignals: 0
2025-11-05 11:51:00,829 - DEBUG - ya.test - _save_outputs: Command (pid 1877881) nswap: 0
2025-11-05 11:51:00,830 - DEBUG - ya.test - _save_outputs: Command (pid 1877881) nvcsw: 637
2025-11-05 11:51:00,830 - DEBUG - ya.test - _save_outputs: Command (pid 1877881) oublock: 8
2025-11-05 11:51:00,830 - DEBUG - ya.test - _save_outputs: Command (pid 1877881) stime: 0.295718
2025-11-05 11:51:00,832 - DEBUG - ya.test - _save_outputs: Command (pid 1877881) utime: 0.575126
2025-11-05 11:51:00,832 - DEBUG - ya.test - _save_outputs: Command (pid 1877881) wtime: 1.471
2025-11-05 11:51:00,833 - DEBUG - ya.test - _save_outputs: Command (pid 1877881) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-05 11:51:00,833 - DEBUG - ya.test - _save_outputs: Command (pid 1877881) errors:

2025-11-05 11:51:00,834 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/c688/0027b2/ydb/apps/ydbd/ydbd
2025-11-05 11:51:00,834 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/c688/0027b2/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:16151', '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 11:51:00,835 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-05 11:51:00,836 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-05 11:51:00,836 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/c688/0027b2/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:16151', '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 11:51:00,851 - DEBUG - ya.test - execute: Command pid: 1878172
2025-11-05 11:51:01,796 - DEBUG - ya.test - _save_outputs: Command (pid 1878172) rc: 0
2025-11-05 11:51:01,798 - DEBUG - ya.test - _save_outputs: Command (pid 1878172) elapsed time (sec): 0.9422507286071777
2025-11-05 11:51:01,798 - DEBUG - ya.test - _save_outputs: Command (pid 1878172) idrss: 0
2025-11-05 11:51:01,799 - DEBUG - ya.test - _save_outputs: Command (pid 1878172) inblock: 0
2025-11-05 11:51:01,799 - DEBUG - ya.test - _save_outputs: Command (pid 1878172) isrss: 0
2025-11-05 11:51:01,800 - DEBUG - ya.test - _save_outputs: Command (pid 1878172) ixrss: 0
2025-11-05 11:51:01,800 - DEBUG - ya.test - _save_outputs: Command (pid 1878172) majflt: 0
2025-11-05 11:51:01,801 - DEBUG - ya.test - _save_outputs: Command (pid 1878172) maxrss: 600304
2025-11-05 11:51:01,802 - DEBUG - ya.test - _save_outputs: Command (pid 1878172) minflt: 51678
2025-11-05 11:51:01,802 - DEBUG - ya.test - _save_outputs: Command (pid 1878172) msgrcv: 0
2025-11-05 11:51:01,803 - DEBUG - ya.test - _save_outputs: Command (pid 1878172) msgsnd: 0
2025-11-05 11:51:01,803 - DEBUG - ya.test - _save_outputs: Command (pid 1878172) nivcsw: 181
2025-11-05 11:51:01,803 - DEBUG - ya.test - _save_outputs: Command (pid 1878172) nsignals: 0
2025-11-05 11:51:01,804 - DEBUG - ya.test - _save_outputs: Command (pid 1878172) nswap: 0
2025-11-05 11:51:01,807 - DEBUG - ya.test - _save_outputs: Command (pid 1878172) nvcsw: 597
2025-11-05 11:51:01,808 - DEBUG - ya.test - _save_outputs: Command (pid 1878172) oublock: 8
2025-11-05 11:51:01,808 - DEBUG - ya.test - _save_outputs: Command (pid 1878172) stime: 0.255374
2025-11-05 11:51:01,809 - DEBUG - ya.test - _save_outputs: Command (pid 1878172) utime: 0.575804
2025-11-05 11:51:01,809 - DEBUG - ya.test - _save_outputs: Command (pid 1878172) wtime: 0.957
2025-11-05 11:51:01,810 - DEBUG - ya.test - _save_outputs: Command (pid 1878172) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-11-05 11:51:01,810 - DEBUG - ya.test - _save_outputs: Command (pid 1878172) errors:

2025-11-05 11:51:01,811 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-05 11:51:02,135 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-05 11:51:02,320 - 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 11:51:02,328 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-05 11:51:02,329 - 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 11:51:02,370 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-05 11:51:02,371 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 26b816d3-9b71-4319-b251-b92cc399fc4d, localhost:16151): creating call state
2025-11-05 11:51:02,373 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 26b816d3-9b71-4319-b251-b92cc399fc4d, localhost:16151): request = { database: "/Root" }
2025-11-05 11:51:02,384 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 26b816d3-9b71-4319-b251-b92cc399fc4d, localhost:16151): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-anwhr6cmha.auto.internal" port: 16151 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 11:51:02,385 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-anwhr6cmha.auto.internal:16151, location 1, ssl: False>]>
2025-11-05 11:51:02,386 - 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 11:51:02,410 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:16151
2025-11-05 11:51:02,411 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 100, will create new one.
2025-11-05 11:51:02,413 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 7fdfe08b-2117-4a4b-b8cf-dac1b5e7c2c8, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:02,414 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 7fdfe08b-2117-4a4b-b8cf-dac1b5e7c2c8, ghrun-anwhr6cmha.auto.internal:16151): request = {  }
2025-11-05 11:51:02,424 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 7fdfe08b-2117-4a4b-b8cf-dac1b5e7c2c8, ghrun-anwhr6cmha.auto.internal:16151): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" node_id: 1 }
2025-11-05 11:51:02,425 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, 6013fea7-58ab-4df5-bfd9-77305bb829e4, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:02,426 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, 6013fea7-58ab-4df5-bfd9-77305bb829e4, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" }
2025-11-05 11:51:02,435 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, 6013fea7-58ab-4df5-bfd9-77305bb829e4, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:02,452 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:02,453 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4d07ee76-a92a-4261-904d-a61c163ba4ab, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:02,454 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4d07ee76-a92a-4261-904d-a61c163ba4ab, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:02,455 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4d07ee76-a92a-4261-904d-a61c163ba4ab, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:06,490 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:06,491 - INFO - __tests__.alter_compression - create_table_without_compression: Table /Root/all_compression/all_supported_compression/off_compression created
2025-11-05 11:51:06,492 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:06,493 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2448d43c-e3d9-45d6-842a-31a80b9f10b6, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:06,493 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2448d43c-e3d9-45d6-842a-31a80b9f10b6, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:06,499 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2448d43c-e3d9-45d6-842a-31a80b9f10b6, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:07,654 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:07,655 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:07,656 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1fe95c3e-e84b-4074-9696-80cbbb776e0d, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:07,657 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1fe95c3e-e84b-4074-9696-80cbbb776e0d, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:07,690 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1fe95c3e-e84b-4074-9696-80cbbb776e0d, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:08,801 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:08,802 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:08,803 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 521f8337-938f-4709-b82d-baf0b18eef74, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:08,804 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 521f8337-938f-4709-b82d-baf0b18eef74, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:08,805 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 521f8337-938f-4709-b82d-baf0b18eef74, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:09,767 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:09,768 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:09,769 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 20692818-b0dc-4688-835c-1fbdf44f7c05, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:09,770 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 20692818-b0dc-4688-835c-1fbdf44f7c05, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:09,772 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 20692818-b0dc-4688-835c-1fbdf44f7c05, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:12,021 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:12,021 - 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 11:51:12,022 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:12,023 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ccfebefc-b401-44b9-b16c-cbcd75f7d152, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:12,024 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ccfebefc-b401-44b9-b16c-cbcd75f7d152, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:12,026 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ccfebefc-b401-44b9-b16c-cbcd75f7d152, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:12,959 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:12,960 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:12,961 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 155c908c-f50d-4307-b0f0-1464108aa527, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:12,962 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 155c908c-f50d-4307-b0f0-1464108aa527, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:12,972 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 155c908c-f50d-4307-b0f0-1464108aa527, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:13,283 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:13,284 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:13,285 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 9c27f827-f6a8-45d6-9ca9-4e8c4c41fa3f, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:13,286 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 9c27f827-f6a8-45d6-9ca9-4e8c4c41fa3f, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:13,287 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 9c27f827-f6a8-45d6-9ca9-4e8c4c41fa3f, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:14,048 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:14,049 - 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 11:51:14,050 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:14,050 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 39f26847-73b8-4c9c-a75d-6f6dd2b724d3, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:14,052 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 39f26847-73b8-4c9c-a75d-6f6dd2b724d3, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:14,058 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 39f26847-73b8-4c9c-a75d-6f6dd2b724d3, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:15,036 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:15,037 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:15,038 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, b0575198-085c-4f96-bc23-042d9d712763, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:15,039 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, b0575198-085c-4f96-bc23-042d9d712763, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:15,041 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, b0575198-085c-4f96-bc23-042d9d712763, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:15,306 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:15,307 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:15,308 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 147370d4-f7a0-4665-9b8c-7d7da4f4918a, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:15,308 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 147370d4-f7a0-4665-9b8c-7d7da4f4918a, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:15,310 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 147370d4-f7a0-4665-9b8c-7d7da4f4918a, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:15,963 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:15,964 - 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 11:51:15,965 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:15,965 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 611231e8-919e-4264-981d-eca1ca2c932b, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:15,967 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 611231e8-919e-4264-981d-eca1ca2c932b, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:15,969 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 611231e8-919e-4264-981d-eca1ca2c932b, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:17,119 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:17,120 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:17,120 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0c31e384-ae26-434c-ad79-273b4366a315, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:17,121 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0c31e384-ae26-434c-ad79-273b4366a315, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:17,123 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0c31e384-ae26-434c-ad79-273b4366a315, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:17,375 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:17,377 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:17,390 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2c11be22-791b-4126-af96-4432aa4849f3, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:17,392 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2c11be22-791b-4126-af96-4432aa4849f3, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:17,394 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2c11be22-791b-4126-af96-4432aa4849f3, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:17,971 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:17,972 - 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 11:51:17,972 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:17,973 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d5fd7123-50c6-41c6-9c91-6e377a5320bc, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:17,974 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d5fd7123-50c6-41c6-9c91-6e377a5320bc, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:17,976 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d5fd7123-50c6-41c6-9c91-6e377a5320bc, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:18,990 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:18,991 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:18,992 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d9106024-6152-449d-95fb-a9952dbc80cb, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:18,993 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d9106024-6152-449d-95fb-a9952dbc80cb, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:18,995 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d9106024-6152-449d-95fb-a9952dbc80cb, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:19,302 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:19,303 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:19,304 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f0f2588f-ba18-4107-81f3-7d3bd5851731, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:19,305 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f0f2588f-ba18-4107-81f3-7d3bd5851731, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:19,307 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f0f2588f-ba18-4107-81f3-7d3bd5851731, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:19,784 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:19,785 - 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 11:51:19,786 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:19,786 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d89c0441-155a-45e3-9781-11817ab3cc84, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:19,788 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d89c0441-155a-45e3-9781-11817ab3cc84, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:19,789 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d89c0441-155a-45e3-9781-11817ab3cc84, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:20,895 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:20,896 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:20,897 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5bf31487-e16d-4501-9a15-ad3e834dd3bf, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:20,898 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5bf31487-e16d-4501-9a15-ad3e834dd3bf, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:20,912 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5bf31487-e16d-4501-9a15-ad3e834dd3bf, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:21,276 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:21,277 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:21,278 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 92a2b676-386d-45f1-86cc-3dc099923de8, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:21,280 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 92a2b676-386d-45f1-86cc-3dc099923de8, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:21,281 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 92a2b676-386d-45f1-86cc-3dc099923de8, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:21,835 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:21,836 - 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 11:51:21,837 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:21,837 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8cd4f6b0-7996-40bc-9855-a7098f7e7b95, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:21,843 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8cd4f6b0-7996-40bc-9855-a7098f7e7b95, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:21,845 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8cd4f6b0-7996-40bc-9855-a7098f7e7b95, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:23,075 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:23,076 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:23,077 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 48472c47-d73c-4006-ba10-90986bcbddf4, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:23,078 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 48472c47-d73c-4006-ba10-90986bcbddf4, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:23,081 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 48472c47-d73c-4006-ba10-90986bcbddf4, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:23,314 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:23,315 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:23,316 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 59d4c655-3874-4879-821c-6536aa8ca8be, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:23,317 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 59d4c655-3874-4879-821c-6536aa8ca8be, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:23,319 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 59d4c655-3874-4879-821c-6536aa8ca8be, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:23,952 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:23,953 - 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 11:51:23,953 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:23,954 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0e4f0512-1bf7-40ea-a2e6-13fda2c4f039, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:23,954 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0e4f0512-1bf7-40ea-a2e6-13fda2c4f039, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:23,956 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0e4f0512-1bf7-40ea-a2e6-13fda2c4f039, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:24,880 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:24,881 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:24,882 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 58802a6f-3edf-4c03-8d07-b5f188e8b8de, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:24,883 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 58802a6f-3edf-4c03-8d07-b5f188e8b8de, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:24,884 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 58802a6f-3edf-4c03-8d07-b5f188e8b8de, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:25,445 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:25,446 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:25,447 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1bafb306-b9fd-4d31-9ebb-ede103084289, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:25,447 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1bafb306-b9fd-4d31-9ebb-ede103084289, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:25,449 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1bafb306-b9fd-4d31-9ebb-ede103084289, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:26,191 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:26,191 - 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 11:51:26,192 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:26,193 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 69d78342-5278-48ca-90ca-00f8691969db, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:26,194 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 69d78342-5278-48ca-90ca-00f8691969db, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:26,196 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 69d78342-5278-48ca-90ca-00f8691969db, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:27,745 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:27,746 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:27,747 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0d925523-e661-4e83-b187-0746c1e01d33, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:27,748 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0d925523-e661-4e83-b187-0746c1e01d33, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:27,749 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0d925523-e661-4e83-b187-0746c1e01d33, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:28,208 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:28,209 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:28,210 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 5713be74-c138-4210-b3cc-2914496ac338, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:28,211 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 5713be74-c138-4210-b3cc-2914496ac338, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:28,213 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 5713be74-c138-4210-b3cc-2914496ac338, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:29,045 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:29,046 - 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 11:51:29,046 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:29,047 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e294191d-d0bf-4ad4-b08d-20b6f2e1f768, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:29,048 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e294191d-d0bf-4ad4-b08d-20b6f2e1f768, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:29,050 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e294191d-d0bf-4ad4-b08d-20b6f2e1f768, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:30,691 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:30,692 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:30,693 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 22dc4e38-0f22-4d0b-87d3-dc272466eb7c, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:30,694 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 22dc4e38-0f22-4d0b-87d3-dc272466eb7c, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:30,704 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 22dc4e38-0f22-4d0b-87d3-dc272466eb7c, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:31,042 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:31,043 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:31,044 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f9177573-7023-41d1-aee4-ae62783e0604, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:31,045 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f9177573-7023-41d1-aee4-ae62783e0604, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:31,047 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f9177573-7023-41d1-aee4-ae62783e0604, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:31,854 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:31,855 - 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 11:51:31,855 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:31,856 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f80ceab6-040a-4b80-9d48-1a6e3b6d03bb, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:31,857 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f80ceab6-040a-4b80-9d48-1a6e3b6d03bb, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:31,860 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f80ceab6-040a-4b80-9d48-1a6e3b6d03bb, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:33,486 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:33,487 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:33,488 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 449b4a3e-3dd5-4355-b45e-7f068e6d45a7, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:33,489 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 449b4a3e-3dd5-4355-b45e-7f068e6d45a7, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:33,490 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 449b4a3e-3dd5-4355-b45e-7f068e6d45a7, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:34,082 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:34,083 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:34,084 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 348bc37e-6685-4b1e-ba74-247d5de4965b, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:34,085 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 348bc37e-6685-4b1e-ba74-247d5de4965b, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:34,086 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 348bc37e-6685-4b1e-ba74-247d5de4965b, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:34,928 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:34,929 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:34,930 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, ea4fa7da-92af-4f23-82ab-3e3d2d76c218, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:34,931 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, ea4fa7da-92af-4f23-82ab-3e3d2d76c218, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:34,932 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, ea4fa7da-92af-4f23-82ab-3e3d2d76c218, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:40,378 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:50,420 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:50,421 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 445a0b93-af1a-4a58-a795-8ba9a70bd433, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:50,422 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 445a0b93-af1a-4a58-a795-8ba9a70bd433, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:50,424 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 445a0b93-af1a-4a58-a795-8ba9a70bd433, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:53,515 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:53,559 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8092160)
2025-11-05 11:51:53,560 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:51:53,560 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7335bf0f-dd20-4488-a928-2b33da6892d8, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:51:53,561 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7335bf0f-dd20-4488-a928-2b33da6892d8, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:51:53,563 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7335bf0f-dd20-4488-a928-2b33da6892d8, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:51:56,320 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:06,361 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:06,362 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d2531462-483e-4b2e-bd18-77488f90143a, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:06,363 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d2531462-483e-4b2e-bd18-77488f90143a, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:52:06,364 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d2531462-483e-4b2e-bd18-77488f90143a, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:07,239 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-05 11:52:07,239 - 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 11:52:07,251 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-05 11:52:07,252 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 343ae906-a5f9-40ea-b78e-d0c481f453d5, localhost:16151): creating call state
2025-11-05 11:52:07,252 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 343ae906-a5f9-40ea-b78e-d0c481f453d5, localhost:16151): request = { database: "/Root" }
2025-11-05 11:52:07,260 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 343ae906-a5f9-40ea-b78e-d0c481f453d5, localhost:16151): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-anwhr6cmha.auto.internal" port: 16151 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 11:52:07,261 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-anwhr6cmha.auto.internal:16151, location 1, ssl: False>]>
2025-11-05 11:52:07,265 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:16151
2025-11-05 11:52:09,313 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:19,339 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:19,340 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e62913f7-f513-4b71-a073-fee0f1d1dd17, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:19,341 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e62913f7-f513-4b71-a073-fee0f1d1dd17, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:52:19,342 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e62913f7-f513-4b71-a073-fee0f1d1dd17, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:20,417 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:30,421 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:30,520 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 7cdf00f3-c137-459c-8be2-796bda6d79ad, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:30,521 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 7cdf00f3-c137-459c-8be2-796bda6d79ad, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:52:30,522 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 7cdf00f3-c137-459c-8be2-796bda6d79ad, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:31,218 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:31,221 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/off_compression`, volumes `value` (8000000, 8009216)
2025-11-05 11:52:31,222 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:31,223 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6ac62694-0976-417e-999e-e2ba71a8d70d, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:31,224 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6ac62694-0976-417e-999e-e2ba71a8d70d, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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 11:52:31,225 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6ac62694-0976-417e-999e-e2ba71a8d70d, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:31,496 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:31,500 - INFO - ya.test - pytest_runtest_call: Test call (class_name: alter_compression.py::TestAllCompression, test_name: test_all_supported_compression[zstd_8_compression-COMPRESSION = "zstd", COMPRESSION_LEVEL = 8])
2025-11-05 11:52:31,500 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:31,501 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f78a4eae-e960-4c2d-844a-1e63fa608a95, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:31,502 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f78a4eae-e960-4c2d-844a-1e63fa608a95, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "\n                CREATE TABLE `/Root/all_compression/all_supported_compression/zstd_8_compression` (\n                    value Uint64 NOT NULL,\n                    value1 Uint64,\n                    PRIMARY KEY(value),\n                    FAMILY default (COMPRESSION = \"zstd\", COMPRESSION_LEVEL = 8)\n                )\n                WITH (STORE = COLUMN)\n                " } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:31,504 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f78a4eae-e960-4c2d-844a-1e63fa608a95, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:34,413 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:34,414 - INFO - __tests__.alter_compression - test_all_supported_compression: Table /Root/all_compression/all_supported_compression/zstd_8_compression created
2025-11-05 11:52:34,415 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:34,416 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8245c591-f35f-4940-9694-817f1636d71c, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:34,416 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8245c591-f35f-4940-9694-817f1636d71c, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_8_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:34,418 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8245c591-f35f-4940-9694-817f1636d71c, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:35,177 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:35,231 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:35,232 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c5311c0c-5873-42b3-b26b-8497f409bf74, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:35,233 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c5311c0c-5873-42b3-b26b-8497f409bf74, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:35,235 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c5311c0c-5873-42b3-b26b-8497f409bf74, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:37,709 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:37,710 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:37,711 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4772899e-021b-4d9d-9a9c-ff6ad85977d9, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:37,711 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4772899e-021b-4d9d-9a9c-ff6ad85977d9, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:37,713 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4772899e-021b-4d9d-9a9c-ff6ad85977d9, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:38,632 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:38,633 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:38,633 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, f68a114c-6af9-4a94-8737-2b131a715e21, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:38,634 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, f68a114c-6af9-4a94-8737-2b131a715e21, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:38,635 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, f68a114c-6af9-4a94-8737-2b131a715e21, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:40,442 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:40,443 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 100000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 100000, 'Portions': 64}}, blobs: {'__DEFAULT': {'Portions': 64, 'BlobSize': 318016, 'BlobCount': 128}}
2025-11-05 11:52:40,443 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:40,444 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, dcf29753-9d9a-4284-bfa3-5edf2363cacc, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:40,445 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, dcf29753-9d9a-4284-bfa3-5edf2363cacc, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:40,459 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, dcf29753-9d9a-4284-bfa3-5edf2363cacc, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:42,583 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:42,583 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:42,584 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 43bee753-b7b2-4a88-b6ca-fd672e824600, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:42,589 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 43bee753-b7b2-4a88-b6ca-fd672e824600, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:42,592 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 43bee753-b7b2-4a88-b6ca-fd672e824600, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:42,992 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:42,993 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:42,994 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c1c26e85-19a6-4d80-b133-9a896789837e, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:42,995 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c1c26e85-19a6-4d80-b133-9a896789837e, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:42,996 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c1c26e85-19a6-4d80-b133-9a896789837e, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:43,391 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:43,392 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 200000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 200000, 'Portions': 128}}, blobs: {'__DEFAULT': {'Portions': 128, 'BlobSize': 637312, 'BlobCount': 256}}
2025-11-05 11:52:43,393 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:43,393 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, daf0138b-595f-44df-bb28-1b091d7eee21, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:43,394 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, daf0138b-595f-44df-bb28-1b091d7eee21, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:43,396 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, daf0138b-595f-44df-bb28-1b091d7eee21, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:45,223 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:45,223 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:45,231 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3b091b35-a587-4ccf-bfa9-0ea72d6c125a, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:45,232 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3b091b35-a587-4ccf-bfa9-0ea72d6c125a, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:45,233 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3b091b35-a587-4ccf-bfa9-0ea72d6c125a, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:45,451 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:45,451 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:45,452 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 10dedc43-9b01-4d47-b744-1722a0294d75, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:45,453 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 10dedc43-9b01-4d47-b744-1722a0294d75, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:45,455 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 10dedc43-9b01-4d47-b744-1722a0294d75, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:45,931 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:45,931 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 300000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 300000, 'Portions': 192}}, blobs: {'__DEFAULT': {'Portions': 192, 'BlobSize': 956352, 'BlobCount': 384}}
2025-11-05 11:52:45,932 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:45,932 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8a894e18-95b5-46ca-b1dc-3b12f69a72ef, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:45,933 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8a894e18-95b5-46ca-b1dc-3b12f69a72ef, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:45,935 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8a894e18-95b5-46ca-b1dc-3b12f69a72ef, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:47,600 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:47,601 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:47,601 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4d81c67b-26f8-4312-9474-d5fe1141db3f, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:47,602 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4d81c67b-26f8-4312-9474-d5fe1141db3f, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:47,603 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4d81c67b-26f8-4312-9474-d5fe1141db3f, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:47,860 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:47,915 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:47,916 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 41160c73-9f60-46fc-90bf-fb387272b0e8, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:47,917 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 41160c73-9f60-46fc-90bf-fb387272b0e8, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:47,919 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 41160c73-9f60-46fc-90bf-fb387272b0e8, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:48,401 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:48,402 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 400000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 400000, 'Portions': 256}}, blobs: {'__DEFAULT': {'Portions': 256, 'BlobSize': 1275712, 'BlobCount': 512}}
2025-11-05 11:52:48,403 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:48,403 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d66f7344-6b59-43e5-88dc-0593a958a939, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:48,404 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d66f7344-6b59-43e5-88dc-0593a958a939, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:48,406 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d66f7344-6b59-43e5-88dc-0593a958a939, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:49,972 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:49,972 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:49,973 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0a81981c-62f6-4694-9816-ee162e4f08d3, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:49,973 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0a81981c-62f6-4694-9816-ee162e4f08d3, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:49,974 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0a81981c-62f6-4694-9816-ee162e4f08d3, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:50,186 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:50,187 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:50,187 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 53796a53-b937-4079-ac8a-eda213ad771c, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:50,188 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 53796a53-b937-4079-ac8a-eda213ad771c, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:50,189 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 53796a53-b937-4079-ac8a-eda213ad771c, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:50,637 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:50,638 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 500000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 500000, 'Portions': 320}}, blobs: {'__DEFAULT': {'Portions': 320, 'BlobSize': 1594672, 'BlobCount': 640}}
2025-11-05 11:52:50,638 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:50,639 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 20270093-f835-4317-8c66-dad6a5180f3c, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:50,640 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 20270093-f835-4317-8c66-dad6a5180f3c, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:50,641 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 20270093-f835-4317-8c66-dad6a5180f3c, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:51,970 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:51,971 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:51,971 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0d62f54d-2348-4e1b-852f-5313da8b1205, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:51,972 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0d62f54d-2348-4e1b-852f-5313da8b1205, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:51,973 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0d62f54d-2348-4e1b-852f-5313da8b1205, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:52,132 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:52,133 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:52,134 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e6db4daa-1914-4854-9ccb-d57231ce37b0, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:52,134 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e6db4daa-1914-4854-9ccb-d57231ce37b0, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:52,135 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e6db4daa-1914-4854-9ccb-d57231ce37b0, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:52,501 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:52,502 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 600000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 600000, 'Portions': 384}}, blobs: {'__DEFAULT': {'Portions': 384, 'BlobSize': 1913856, 'BlobCount': 768}}
2025-11-05 11:52:52,503 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:52,503 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, effb791b-12f1-4f20-a421-171b71e36a17, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:52,504 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, effb791b-12f1-4f20-a421-171b71e36a17, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:52,505 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, effb791b-12f1-4f20-a421-171b71e36a17, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:53,702 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:53,703 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:53,703 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 6f2c6ebd-56fb-4d51-af06-759a650d6188, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:53,704 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 6f2c6ebd-56fb-4d51-af06-759a650d6188, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:53,706 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 6f2c6ebd-56fb-4d51-af06-759a650d6188, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:53,884 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:53,946 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:53,947 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 211b24b2-9c09-494f-ac49-649cee6668a8, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:53,948 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 211b24b2-9c09-494f-ac49-649cee6668a8, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:53,949 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 211b24b2-9c09-494f-ac49-649cee6668a8, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:54,295 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:54,295 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 700000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 700000, 'Portions': 448}}, blobs: {'__DEFAULT': {'Portions': 448, 'BlobSize': 2232992, 'BlobCount': 896}}
2025-11-05 11:52:54,295 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:54,296 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 20eac2a7-ec0e-48ee-9ff3-721b8992d8f2, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:54,296 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 20eac2a7-ec0e-48ee-9ff3-721b8992d8f2, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:54,297 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 20eac2a7-ec0e-48ee-9ff3-721b8992d8f2, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:56,080 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:56,080 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:56,081 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, dd9c726b-568c-4498-9f2b-cf00f9689761, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:56,082 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, dd9c726b-568c-4498-9f2b-cf00f9689761, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:56,097 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, dd9c726b-568c-4498-9f2b-cf00f9689761, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:56,346 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:56,346 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:56,347 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2094e494-5604-4a42-8552-7976c3343d45, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:56,348 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2094e494-5604-4a42-8552-7976c3343d45, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:56,350 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2094e494-5604-4a42-8552-7976c3343d45, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:56,973 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:56,974 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 800000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 800000, 'Portions': 512}}, blobs: {'__DEFAULT': {'Portions': 512, 'BlobSize': 2552480, 'BlobCount': 1024}}
2025-11-05 11:52:56,974 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:56,975 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, d96b7187-a88c-465c-8a15-d52db4d328f1, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:56,976 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, d96b7187-a88c-465c-8a15-d52db4d328f1, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:56,977 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, d96b7187-a88c-465c-8a15-d52db4d328f1, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:58,595 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:58,596 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:58,596 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 1a31dc28-a781-4ba5-bb44-7f2a37761946, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:58,597 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 1a31dc28-a781-4ba5-bb44-7f2a37761946, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:58,598 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 1a31dc28-a781-4ba5-bb44-7f2a37761946, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:58,846 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:58,846 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:58,847 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 36008995-ac81-46e7-80e4-6f22a055c774, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:58,848 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 36008995-ac81-46e7-80e4-6f22a055c774, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:58,849 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 36008995-ac81-46e7-80e4-6f22a055c774, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:52:59,539 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:59,540 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 900000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 900000, 'Portions': 576}}, blobs: {'__DEFAULT': {'Portions': 576, 'BlobSize': 2871488, 'BlobCount': 1152}}
2025-11-05 11:52:59,540 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:52:59,541 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 32c88b27-1cd0-400e-bca4-05277f76a319, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:52:59,544 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 32c88b27-1cd0-400e-bca4-05277f76a319, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression`\n                SELECT * FROM AS_TABLE($rows);\n            " } stats_mode: STATS_MODE_NONE }
2025-11-05 11:52:59,546 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 32c88b27-1cd0-400e-bca4-05277f76a319, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:53:01,334 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:53:01,334 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:53:01,335 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, c3569bf6-1017-4b87-953e-4df8483419a0, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:53:01,336 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, c3569bf6-1017-4b87-953e-4df8483419a0, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 11:53:01,338 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, c3569bf6-1017-4b87-953e-4df8483419a0, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:53:01,634 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:53:01,635 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:53:01,636 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, e3f61bf4-60fe-4cca-8193-d2d9f5b946b3, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:53:01,637 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, e3f61bf4-60fe-4cca-8193-d2d9f5b946b3, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression/.sys/primary_index_stats` group by TabletId, PortionId, TierName\n            ) group by TierName\n        " } stats_mode: STATS_MODE_NONE }
2025-11-05 11:53:01,638 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, e3f61bf4-60fe-4cca-8193-d2d9f5b946b3, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:53:02,400 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:53:02,401 - INFO - __tests__.alter_compression - upsert_and_wait_portions: 1000000 rows in /Root/all_compression/all_supported_compression/zstd_8_compression. portions: {'__DEFAULT': {'Rows': 1000000, 'Portions': 640}}, blobs: {'__DEFAULT': {'Portions': 640, 'BlobSize': 3190992, 'BlobCount': 1280}}
2025-11-05 11:53:02,401 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:53:02,402 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8914f9cd-4d56-4c84-867c-c114fb9c425c, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:53:02,403 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8914f9cd-4d56-4c84-867c-c114fb9c425c, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT COUNT(*) AS Rows FROM `/Root/all_compression/all_supported_compression/zstd_8_compression`" } stats_mode: STATS_MODE_NONE }
2025-11-05 11:53:02,404 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8914f9cd-4d56-4c84-867c-c114fb9c425c, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:53:03,698 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:53:03,699 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:53:03,700 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 62a9416d-303b-4c47-84b8-d1cecb6bfb57, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:53:03,701 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 62a9416d-303b-4c47-84b8-d1cecb6bfb57, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 11:53:03,702 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 62a9416d-303b-4c47-84b8-d1cecb6bfb57, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:53:03,992 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:53:03,993 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:53:03,993 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 913126b9-5646-4773-a2d3-49074a5181cb, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:53:03,994 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 913126b9-5646-4773-a2d3-49074a5181cb, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 11:53:03,996 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 913126b9-5646-4773-a2d3-49074a5181cb, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:53:04,280 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:53:04,281 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:53:04,282 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 24c3a4f8-7e81-4d49-9132-21dbc00a3c35, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:53:04,282 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 24c3a4f8-7e81-4d49-9132-21dbc00a3c35, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-05 11:53:04,284 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 24c3a4f8-7e81-4d49-9132-21dbc00a3c35, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:53:08,068 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:53:18,103 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:53:18,104 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 14e55446-35ab-4979-a3aa-1b751e97bfc8, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:53:18,105 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 14e55446-35ab-4979-a3aa-1b751e97bfc8, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-05 11:53:18,112 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 14e55446-35ab-4979-a3aa-1b751e97bfc8, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:53:22,308 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:53:22,347 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_8_compression`, volumes `value` (8000000, 1595496)
2025-11-05 11:53:22,348 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:53:22,349 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 3858e22c-43e1-4e63-ba7f-a48b38fb9c75, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:53:22,350 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 3858e22c-43e1-4e63-ba7f-a48b38fb9c75, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" 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_8_compression/.sys/primary_index_portion_stats` group by TierName" } stats_mode: STATS_MODE_NONE }
2025-11-05 11:53:22,351 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 3858e22c-43e1-4e63-ba7f-a48b38fb9c75, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:53:22,742 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:53:22,746 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:53:22,746 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 4abf82a8-3c65-4828-8f48-084f642d5e1f, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:53:22,747 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 4abf82a8-3c65-4828-8f48-084f642d5e1f, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-05 11:53:22,749 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 4abf82a8-3c65-4828-8f48-084f642d5e1f, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:53:26,345 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:53:36,398 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:53:36,399 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2c4bc0b3-f019-4903-b163-f4d586da2521, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:53:36,400 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2c4bc0b3-f019-4903-b163-f4d586da2521, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-05 11:53:36,402 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2c4bc0b3-f019-4903-b163-f4d586da2521, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:53:41,594 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:53:51,631 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:53:51,632 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 2bceef88-c648-4c7c-9a89-ec79727d09e4, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:53:51,633 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 2bceef88-c648-4c7c-9a89-ec79727d09e4, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-05 11:53:51,635 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 2bceef88-c648-4c7c-9a89-ec79727d09e4, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:53:53,002 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:53:59,169 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-05 11:53:59,170 - 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 11:53:59,188 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-05 11:53:59,189 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, d2947caf-fd36-422a-828c-a63e202edf2f, localhost:16151): creating call state
2025-11-05 11:53:59,190 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, d2947caf-fd36-422a-828c-a63e202edf2f, localhost:16151): request = { database: "/Root" }
2025-11-05 11:53:59,201 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, d2947caf-fd36-422a-828c-a63e202edf2f, localhost:16151): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-anwhr6cmha.auto.internal" port: 16151 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 11:53:59,202 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-anwhr6cmha.auto.internal:16151, location 1, ssl: False>]>
2025-11-05 11:53:59,203 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:16151
2025-11-05 11:54:03,012 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:54:03,013 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 8fb516e7-8565-4513-a7a3-fdcd154036fb, ghrun-anwhr6cmha.auto.internal:16151): creating call state
2025-11-05 11:54:03,014 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 8fb516e7-8565-4513-a7a3-fdcd154036fb, ghrun-anwhr6cmha.auto.internal:16151): request = { session_id: "ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM `/Root/all_compression/all_supported_compression/zstd_8_compression/.sys/primary_index_stats` WHERE Activity == 1 AND EntityName = \"value\"" } stats_mode: STATS_MODE_NONE }
2025-11-05 11:54:03,015 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 8fb516e7-8565-4513-a7a3-fdcd154036fb, ghrun-anwhr6cmha.auto.internal:16151): response = { <_MultiThreadedRendezvous object> }
2025-11-05 11:54:04,749 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=MjA4YWU2MTUtOTk3OTdkMTEtMjA4MjY0My1mYzlkOTQxMQ==
2025-11-05 11:54:04,753 - INFO - root - get_volumes_column: Table `/Root/all_compression/all_supported_compression/zstd_8_compression`, volumes `value` (8000000, 1465240)
2025-11-05 11:54:04,753 - INFO - root - test_all_supported_compression: compression in `/Root/all_compression/all_supported_compression/zstd_8_compression` 8092160 / 1465240: 5.522753951571073
2025-11-05 11:54:04,799 - INFO - ya.test - pytest_runtest_teardown: Test teardown
